Timeout Question

[invoso.com]

I use timeout parameter to disconnect prepaid connection.

 

I use:

112810.979 6 55 19 RunModule start Evaluate, [warning 30 sekund], iModuleIdx=726, previous: vgm=664, vgs=14:14
112810.979 6 55 19 state [warning 30 sekund] Evaluate [$RV[max_con_time]-30]
112810.979 6 55 19 rv replace start [$RV[max_con_time]-30]
112810.979 6 55 19 rv replace end [818-30]
112810.979 6 55 19 eval [818-30]
112810.979 6 55 19 eval InvokeMember Eval returned
112810.979 6 55 19 rvns add warning 30 sekund_Input|818-30
112810.979 6 55 19 rvns add warning 30 sekund|788
112810.979 6 55 19 creating new (non-global) rv : warning before end
112810.979 6 55 19 rvns add warning before end|788
112810.980 6 55 19 Eval Expr result:[788] stored in RV[warning before end]

 

to warn caller 30 seconds before disconnection i use warning before end to set timeout in "just wait" module.

 

112810.980 6 55 19 state [just wait] Playing wav ()
112810.980 6 55 19 q_scr + evScriptEvent 8001 EV_PLAY_FINISHED
112810.981 6 55 19 q_scr run evScriptEvent sCode=[EV_PLAY_FINISHED] iActionID=0, crn=0 [0|0|0|0|0][|||||] 00:00:00 max:12|00:00:02.0711185
112810.981 6 55 19 se EV_PLAY_FINISHED 8001 0|0|0 || LineState=LS_PLAY_PLAYMSG
112810.981 6 55 19 LsPlayMsg EV_PLAY_FINISHED,EV_PLAY_FINISHED
112810.981 6 55 19 rv replace start
------------------------------
on {timeout $RV[warning before end]} goto [play warning]


------------------------------
112810.981 6 55 19 rv replace end [on {timeout 788} goto [play warning]

]
112810.981 6 55 19 path {EV_PLAY_FINISHED} not found
112810.981 6 55 19 iCurrReplayCount=0, iMaxReplayCount=0
112810.981 6 55 19 t timer set 10 sec : EV_TIMEOUT_HANGUP
112810.981 6 55 19 rv replace start [ $RV[warning before end]]
112810.981 6 55 19 rv replace end [ 788]
112810.981 6 55 19 t timer set 788 sec : EV_TIMEOUT_GOTOMODULE

 

just wait module start at 11:28:10 so + 788 seconds should to start play warning at 11:41:18

but:

 

114150.927 6 55 19 q_scr run evScriptEvent sCode=[EV_TIMEOUT_GOTOMODULE] iActionID=0, crn=0 [0|0|0|0|0][|||||] 00:00:00.7890451 max:12|00:00:02.5111437
114150.927 6 55 19 se EV_TIMEOUT_GOTOMODULE 9002 0|0|0 || LineState=LS_PLAY_PLAYMSGFINISHED
114150.927 6 55 19 LsPlayMsgFinished EV_TIMEOUT_GOTOMODULE,EV_TIMEOUT_GOTOMODULE, [ ], [ ], []
114150.927 6 55 19 rv replace start
------------------------------
on {timeout $RV[warning before end]} goto [play warning]


------------------------------
114150.927 6 55 19 rv replace end [on {timeout 788} goto [play warning]

]
114150.927 6 55 19 path {EV_TIMEOUT_GOTOMODULE} not found
114150.927 6 55 19 FindNextVgmTitleInPathList: next module title is=[play warning]

114150.928 6 55 19 t timer clear (force=False)
114150.928 6 55 19 RunModule start Play, [play warning], iModuleIdx=731, previous: vgm=730, vgs=14:14
114150.928 6 55 19 [play warning] VGMTYPE_PLAY run start
114150.928 6 55 19 CheckForAnyPlayActionsAndSetkeysIfNecessary no PlayActions, vgmidx=731, strPaths=on {timeout 26} goto [Hangup the Call 1]

 

 

why VG follow to nex module at 11:41:50 not at 11:41:18?

 

but next timeout working properly (timeout 26 after 4 seconds long warning prompt make 30 seconds) :

 

114220.295 6 55 19 q_scr run evScriptEvent sCode=[EV_TIMEOUT_GOTOMODULE] iActionID=0, crn=0 [0|0|0|0|0][|||||] 00:00:00.2680154 max:12|00:00:02.5111437
114220.295 6 55 19 se EV_TIMEOUT_GOTOMODULE 9002 0|0|0 || LineState=LS_PLAY_PLAYMSGFINISHED
114220.295 6 55 19 LsPlayMsgFinished EV_TIMEOUT_GOTOMODULE,EV_TIMEOUT_GOTOMODULE, [ ], [ ], []
114220.295 6 55 19 path {EV_TIMEOUT_GOTOMODULE} not found
114220.295 6 55 19 FindNextVgmTitleInPathList: next module title is=[Hangup the Call 1]
114220.295 6 55 19 t timer clear (force=False)
114220.295 6 55 19 RunModule start Hangup the Call, [Hangup the Call 1], iModuleIdx=860, previous: vgm=731, vgs=14:14
114220.295 6 55 19 HangupCall (Hangup Module) crn_in=0, L1=Connected, L2=Running_Normal, lPlayId=0, lRecId=0
114220.295 6 55 19 ccrn_connected=2e40265, crn_NewIncomingCall=0, crn_CurrentMakeCall=0, crn_InProcessOfReleasing=0
114220.295 6 55 19 rv add Hangup Source|Hangup Module

 

 

 

 

 

[SupportTeam]

Looks like there is something happening on your system which makes the timers drift considerably - and it becomes noticeable on longer time intervals.

 

This version of VG should resolve the issue (it will detect timers drifting and adjust accordingly):

 

[old link removed]

 

If you continue to have problems please post full vgEngine trace from this new version - not just excerpts - and quote the timestamps and ports that we should be looking at.

Edited 07/27/2017 12:24 AM by SupportTeam
link updated