invoso.com Report post Posted 07/18/2016 12:55 PM 140411.420 7 62 21 state [agent_hangup_source] Evaluate [$RV[Hangup Source]] 140411.420 7 62 21 rv replace start [$RV[Hangup Source]] 140411.420 7 62 21 rv replace end [LineEvCallState_DISCONNECTED] 140411.420 7 62 21 eval [LineEvCallState_DISCONNECTED] 140411.421 7 62 21 objReturn is NULL for input=[LineEvCallState_DISCONNECTED], try with Cstr 140411.421 7 62 21 eval InvokeMember Eval returned 140411.421 7 62 21 rvns add agent_hangup_source_Input|LineEvCallState_DISCONNECTED 140411.421 7 62 21 rvns add agent_hangup_source|LineEvCallState_DISCONNECTED 140411.421 7 62 21 Eval Expr result:[LineEvCallState_DISCONNECTED] 140411.422 7 62 21 path {LineEvCallState_DISCONNECTED} not found 140411.422 7 62 21 matching path not found [LineEvCallState_DISCONNECTED], try boolean paths. 140411.422 7 62 21 ex: ScriptIo.VGMTYPE_EVALEXPR [LineEvCallState_DISCONNECTED] could not be converted to boolean. Take Success path as string non-empty. 140411.422 7 62 21 FindNextVgmTitleInPathList: next module title is=[pbx_agent_terminating_client] 140411.422 7 62 21 matching path found (Boolean True) 140411.422 7 62 21 t timer clear (force=False) 140411.422 7 62 21 RunModule start 140411.422 7 62 21 RunModule start Run VB Script, [pbx_agent_terminating_client], iModuleIdx=859, previous: vgm=501, vgs=11:11 140411.422 7 62 21 t timer set 30 sec : EV_TIMEOUT_HANGUP 140411.422 7 62 21 QueueUserWorkItem vbScript : modVbs 140411.423 7 62 21 HangupCall exit after starting afterhangup script 140411.423 29 62 21 task runscr Run_VBS vgm=859, file=, engine=[ClearScriptV8] 140411.423 29 62 21 runscr strIni_moduleRunScript_Engine=ClearScriptV8 140411.423 29 62 21 state [pbx_agent_terminating_client] RunScript vbs, onhold= 140411.423 29 62 21 rv replace start ------------------------------ set vg = CreateObject("vgServices.CommandLink") vg.Line_Hangup $RV[caller_lineid] set vg = Nothing ------------------------------ 140411.423 29 62 21 rv replace end [set vg = CreateObject("vgServices.CommandLink") vg.Line_Hangup 37 set vg = Nothing] 140411.423 29 62 21 not saving script (strIni_moduleRunScript_SaveToFile is False|0) 140411.423 29 62 21 runscr waiting. wait=1 140411.423 29 62 21 moh file not specified 140411.423 29 62 21 runscr call ClearScript Execute 140411.423 29 62 21 runscr new VBScriptEngine call 140411.424 29 62 21 runscr .Execute call 140411.425 13 rem remoting link constructor activated: vgServices_CommandLink 140411.428 13 rem Line_Hangup 37 140411.428 13 37 13 q_scr + cmdHangupCall 0 140411.428 7 37 13 q_scr run cmdHangupCall sCode=[] iActionID=0, crn=0 [0|0|0|0|0][|||||] 00:00:00 max:6|00:00:00.0470027 140411.428 7 37 13 HangupCall (qScr) crn_in=0, L1=Connected, L2=Running_Normal, lPlayId=0, lRecId=-559411 140411.428 7 37 13 HangupCall crn_connected=2e801cf, crn_NewCallArriving=0, crn_CurrentMakeCall=0, crn_InProcessOfReleasing=0 140411.428 7 37 13 RecSoundStop begin trunc100ms=0, sCaller=Line_Hangup_Main, lRecId=-559411 140411.428 7 37 13 RecSoundStop lRec_Id_InProcessOfStopping=-559411, lRecId=0 140411.428 7 37 13 q_tel + cmd_RecordStop [0,0,0,0,0][||||] 140411.428 7 37 13 rv add Hangup Source|qScr 140411.429 8 37 13 q_tel run cmd_RecordStop 0 00:00:00.0010000 max:5|00:00:00.2040117 140411.429 7 37 13 HangupCall sScriptToRunOnHangup=[termination.vgs] 140411.429 7 37 13 HangupCall lRec_Id_InProcessOfStopping=-559411, wait till recording cmpletes 140411.429 7 37 13 t timer set 4 sec : EV_TIMEOUT_RunAfterHangupScript 140411.428 29 62 21 engineVbs dispose call 140411.429 29 62 21 runscr sModuleType=Run VB Script 140411.429 29 62 21 runscr .Execute returned. iRunWait=1 140411.429 29 62 21 runscr RunWait_1 script completed 140411.429 29 62 21 runscr sModuleClearScriptProcessWasCalledFrom is current module pbx_agent_terminating_client, clearing setting (.iRunWait=1) 140411.429 29 62 21 runscr RunWait_1 taking fail path as script completed and no next module set 140411.429 29 62 21 FindNextVgmTitleInPathList: next module title is=[Hangup Agent] 140411.430 29 62 21 t timer clear (force=False) 140411.430 29 62 21 RunModule start 140411.430 29 62 21 RunModule start Hangup the Call, [Hangup Agent], iModuleIdx=862, previous: vgm=859, vgs=11:11 140411.430 29 62 21 HangupCall (Hangup Module) crn_in=0, L1=Disconnected, L2=Running_AfterHangup, lPlayId=0, lRecId=0 140411.430 29 62 21 HangupCall crn_connected=0, crn_NewCallArriving=0, crn_CurrentMakeCall=0, crn_InProcessOfReleasing=2e801da 140411.430 29 62 21 rv add Hangup Source|Hangup Module 140411.430 29 62 21 rv add DropCall_Source|Hangup Agent 140411.430 29 62 21 state Hanging up... [Hangup Module] 140411.430 29 62 21 logs not written as LogEntryWritten=1 140411.430 29 62 21 L2_set Idle_WaitingForNextCall (called from HangupCall) 140411.430 29 62 21 t timer set 3 sec : EV_TIMEOUT_AFTERIDLE_ALLOWOUT 140411.431 29 62 21 GoOnHoook_IssueDropCall start (crn_in=2e801da, crn_connected=0, crn_makecall=0, crn_NewCallArriving=0, crn_InProcessOfReleasing=2e801da, L1=Disconnected) 140411.431 29 62 21 t timer set 20 sec : EV_TIMEOUT_WAITFORIDLEAFTERDropCall 140411.431 29 62 21 GoOnHoook_IssueDropCall: set crn_InProcessOfReleasing=2e801da 140411.431 29 62 21 not clearing crn_connected to 0 as crn_CurrentConnected=0 and evnt crn=2e801da 140411.431 29 62 21 set crn_connected=0 (called from GoOnHoook_IssueDropCall) 140411.431 29 62 21 q_tel + cmd_DropCall 2e801da [0,0,0,0,0][||||] 140411.431 29 62 21 GoOnHoook_IssueDropCall end 140411.431 29 62 21 RunModule finish 140411.431 29 62 21 runscr exiting thread at end. 140411.453 8 62 21 q_tel run cmd_DropCall 2e801da 00:00:00.0220013 max:5|00:00:00.2040117 140411.454 19 37 13 ev Dialogic 130,TDX_RECORD, crn=2e801cf, 0,0,0,TM_USRSTOP,, 140411.454 19 37 13 q_scr + evScriptEvent 130 TDX_RECORD 140411.454 7 37 13 q_scr run evScriptEvent sCode=[TDX_RECORD] iActionID=0, crn=2e801cf [0|0|0|0|0][TM_USRSTOP|||||] 00:00:00 max:6|00:00:00.0470027 140411.454 7 37 13 se TDX_RECORD 130 0|0|0 TM_USRSTOP|| LineState=LS_PLAY_PLAYMSGFINISHED 140411.454 7 37 13 LsPlayMsgFinished EV_UNKNOWN_130,TDX_RECORD, [TM_USRSTOP ], [ ], [] 140411.454 7 37 13 path {TDX_RECORD} not found 140411.454 7 37 13 not asr event 140411.455 19 37 13 ev RecEnd -559411 140411.455 19 37 13 q_scr + evScriptEvent 8003 EV_REC_FINISHED 140411.455 7 37 13 q_scr run evScriptEvent sCode=[EV_REC_FINISHED] iActionID=0, crn=0 [-559411|0|0|0|0][|||||] 00:00:00 max:6|00:00:00.0470027 140411.455 7 37 13 se EV_REC_FINISHED 8003 -559411|0|0 || LineState=LS_PLAY_PLAYMSGFINISHED 140411.455 7 37 13 t timer clear (force=False) 140411.455 7 37 13 running AfterHangupScript as recording -559411 completed 140411.456 7 37 13 after hangup script as supplied: [termination.vgs] 140411.456 7 37 13 FindFullPathToScript_VgsOrVgp start [termination.vgs] 140411.456 7 37 13 after hangup script after searching: [termination.vgs] 140411.456 7 LoadedVgs_Find termination.vgs at idx=11 140411.456 7 37 13 After Hangup script run first module 140411.456 7 37 13 L2_set Running_AfterHangup (called from StartAfterHangupScriptIfDefined) 140411.456 7 37 13 t timer clear (force=False) 140411.456 7 37 13 RunModule start 140411.456 7 37 13 RunModule start Evaluate, [pbx_connection_detection], iModuleIdx=858, previous: vgm=626, vgs=11:6 140411.456 7 37 13 state [pbx_connection_detection] Evaluate [$RV[pbx]] 140411.456 7 37 13 rv replace start [$RV[pbx]] 140411.456 7 37 13 rv replace end [true] 140411.456 7 37 13 eval [true] 140411.456 7 37 13 eval InvokeMember Eval returned 140411.456 7 37 13 rvns add pbx_connection_detection_Input|true 140411.456 7 37 13 rvns add pbx_connection_detection|True 140411.456 7 37 13 Eval Expr result:[True] 140411.457 7 37 13 path {True} found (at offset 89) 140411.457 7 37 13 FindNextVgmTitleInPathList: next module title is=[detect_pbx_side] 140411.457 7 37 13 t timer clear (force=False) 140411.457 7 37 13 RunModule start 140411.457 7 37 13 RunModule start Evaluate, [detect_pbx_side], iModuleIdx=861, previous: vgm=858, vgs=11:11 140411.457 7 37 13 state [detect_pbx_side] Evaluate [$RV[pbx_side]] 140411.457 7 37 13 rv replace start [$RV[pbx_side]] 140411.457 7 37 13 rv replace end [client] 140411.457 7 37 13 eval [client] 140411.457 7 37 13 objReturn is NULL for input=[client], try with Cstr 140411.457 7 37 13 eval InvokeMember Eval returned 140411.457 7 37 13 rvns add detect_pbx_side_Input|client 140411.457 7 37 13 rvns add detect_pbx_side|client 140411.458 7 37 13 Eval Expr result:[client] 140411.458 7 37 13 path {client} found (at offset 3) 140411.458 7 37 13 FindNextVgmTitleInPathList: next module title is=[client_hangup_source] 140411.458 7 37 13 t timer clear (force=False) 140411.458 7 37 13 RunModule start 140411.458 7 37 13 RunModule start Evaluate, [client_hangup_source], iModuleIdx=863, previous: vgm=861, vgs=11:11 140411.458 7 37 13 state [client_hangup_source] Evaluate [$RV[Hangup Source]] 140411.458 7 37 13 rv replace start [$RV[Hangup Source]] 140411.458 7 37 13 rv replace end [qScr] 140411.458 7 37 13 eval [qScr] 140411.458 7 37 13 objReturn is NULL for input=[qScr], try with Cstr 140411.458 7 37 13 eval InvokeMember Eval returned 140411.458 7 37 13 rvns add client_hangup_source_Input|qScr 140411.458 7 37 13 rvns add client_hangup_source|qScr 140411.458 7 37 13 Eval Expr result:[qScr] 140411.458 7 37 13 path {qScr} found (at offset 53) 140411.459 7 37 13 FindNextVgmTitleInPathList: next module title is=[vg_polaczenia_update_end_first] 140411.459 7 37 13 t timer clear (force=False) 140411.459 7 37 13 RunModule start 140411.459 7 37 13 RunModule start Database Query, [vg_polaczenia_update_end_first], iModuleIdx=902, previous: vgm=863, vgs=11:11 Hangup $RV[caller_lineid] not terminating call, caller (client) has silence until end of terminating script. Share this post Link to post
SupportTeam Report post Posted 07/19/2016 08:20 AM Quoted trace includes events after Hangup Call was issued and only covers 39 milliseconds of time... (from 140411.420 to 140411.459). Please .ZIP up and post ktTel and vgEngine trace file excerpts (or full files if not too big) that include in them the start of the both calls and at least 30 seconds after the Hangup Call was issued. Share this post Link to post
invoso.com Report post Posted 07/19/2016 08:49 AM As You wish vg_engine.zip Share this post Link to post
SupportTeam Report post Posted 07/19/2016 08:59 AM (edited) Please post the ktTel trace excerpt that covers both calls from start to end. Also, the posted .ZIP file does not include the start of the both calls. The posted .ZIP file starts at 140411.420 - same as the quoted trace beforehand... Edited 07/20/2016 07:24 AM by SupportTeam Share this post Link to post
Sebastian Report post Posted 07/20/2016 11:10 AM Both full files im attachment vg_engine.zip Share this post Link to post
SupportTeam Report post Posted 07/20/2016 12:54 PM ktTel trace shows that person that was connected to port 21 (LineId 62) hung up at 140411.414 : 452 140411.414 5592 62 ev GCEV_DISCONNECTED crn=2e801da462 140411.454 5788 62 fn DropCall(sLineId=62, sXMLOptions=[], crn=2e801da)494 140411.460 5592 62 ev GCEV_DROPCALL crn=2e801da499 140411.461 5788 62 fn ReleaseCall(sLineId=62, crn=2e801da, Param1=0)503 140411.465 5592 62 ev GCEV_RELEASECALL crn=2e801da and that VoiceGuide hung up port 13 (LineID 37) at 140426.661 :593 140426.661 5788 37 fn DropCall(sLineId=37, sXMLOptions=[], crn=2e801cf)600 140427.067 5592 37 ev GCEV_DROPCALL crn=2e801cf605 140427.070 5788 37 fn ReleaseCall(sLineId=37, crn=2e801cf, Param1=0)609 140427.077 5592 37 ev GCEV_RELEASECALL crn=2e801cf And looks like your question is why didn't this call: 140411.428 13 rem Line_Hangup 37 didn't hang up the port 13 (LineID 37). Trace shows a 2-Line call recording is currently active on that line, and the line cannot hang up until the recording completes: 140411.429 7 37 13 HangupCall lRec_Id_InProcessOfStopping=-559411, wait till recording cmpletes The 2-line recording that was started using the COM function call needs to be stopped first (using Record_Stop call). Then, after a short delay, (1 second should be enough), the Line_Hangup call can be issued (or just a normal 'Hangup Call' module used). 140357.443 13 37 13 q_tel + cmd_RecTwoLinesStart 0 [37,62,-559411,6,0][dxxxB4C1|dtiB1T13|dtiB2T6|C:\callrecord\ID20160718_140238_41_13_53720_140357_rd.wav|]140411.428 7 37 13 HangupCall (qScr) crn_in=0, L1=Connected, L2=Running_Normal, lPlayId=0, lRecId=-559411140411.428 7 37 13 RecSoundStop begin trunc100ms=0, sCaller=Line_Hangup_Main, lRecId=-559411140411.428 7 37 13 RecSoundStop lRec_Id_InProcessOfStopping=-559411, lRecId=0140411.429 7 37 13 HangupCall lRec_Id_InProcessOfStopping=-559411, wait till recording cmpletes140411.455 19 37 13 ev RecEnd -559411140411.455 7 37 13 q_scr run evScriptEvent sCode=[EV_REC_FINISHED] iActionID=0, crn=0 [-559411|0|0|0|0][|||||] 00:00:00 max:6|00:00:00.0470027140411.455 7 37 13 se EV_REC_FINISHED 8003 -559411|0|0 || LineState=LS_PLAY_PLAYMSGFINISHED140411.455 7 37 13 running AfterHangupScript as recording -559411 completed Share this post Link to post
SupportTeam Report post Posted 07/20/2016 01:17 PM We've made some changes to way that VoiceGuide reacts in situation where a 2-Line recording is still active when a Line_Hangup is issued. Changes are now included in this daily build: [old link removed] You can try updating your system to this version and running through the scenario as before (leaving the script as is). If you still encounter issues please post full trace files as before. Share this post Link to post
SupportTeam Report post Posted 08/01/2016 09:49 AM Those daily builds only stay up available for download for about a week usually. The changes mentioned before are now included in main v7.5.6 release. Please download from main Downloads page. Share this post Link to post
