ronghuizhang Report post Posted 08/31/2011 01:15 AM Dear VoiceGuide support, We are using VoiceGuid v6.0.3386. Card is D/4PCI-U card. Our customer reported to us that, this happened quite frequent, 10%. What happened is, when dial card made a call to a phone, and the person picked up and say 'yo', dial card just hang up. I looked at the log and found it went to condition to onNotConnected and went to a script and hanged up. I somehow feel, the script was not executed either. Please take a look at the following log, 140035.11 5 OnNotConnected unknown app [c:\toa\callout\UGI_trial\ugi_fax.vgs] ------Here is the place I mean, it says OnNotConnected. But customer told me he heard the ring and picked up and say 'yo' and the software hang up on him. How can I investigate what was really going on? Your help is highly appreciated! 140009.63 5 event EV_TIMEOUT_AFTERIDLE_ALLOWOUT, iCode=9013 state=900 140009.63 5 setting iDialoutReadyToDialout = 1 140019.72 5 dial [1018,915708298973,1107281400,0,2359,MoTuWeThFrSaSu,[],1,c:\toa\callout\UGI_trial\1651152.wav,c:\toa\callout\UGI_trial\ugi_trial1.vgs,c:\toa\callout\UGI_trial\ugi_trial1.vgs,[PhoneNumberCalled]{915708298973}[TOAID]{108}[JOBID]{41}[FirstName]{Jeremy}[LastName]{Boecker}[Jobdesc]{Test Group}[FillCount]{2}[Token]{init}[CallBackPhone]{6107365830},29,0,5,c:\toa\callout\UGI_trial\ugi_fax.vgs,] (search started at 140019.72) 140019.72 5 dial DialOnLine start tel[915708298973] ann[c:\toa\callout\UGI_trial\1651152.wav] vgs[c:\toa\callout\UGI_trial\ugi_trial1.vgs] am[c:\toa\callout\UGI_trial\ugi_trial1.vgs] rv[[PhoneNumberCalled]{915708298973}[TOAID]{108}[JOBID]{41}[FirstName]{Jeremy}[LastName]{Boecker}[Jobdesc]{Test Group}[FillCount]{2}[Token]{init}[CallBackPhone]{6107365830}] cid[] 140019.72 0 dial callque update id=1018: NextCallTime=1107281405(7/28/2011 2:05:19 PM), RetriesLeft=-1 140019.72 5 rv clear all 140019.73 5 rv add [PhoneNumberCalled]{915708298973} 140019.73 5 rv add [TOAID]{108} 140019.73 5 rv add [JOBID]{41} 140019.73 5 rv add [FirstName]{Jeremy} 140019.73 5 rv add [LastName]{Boecker} 140019.73 5 rv add [Jobdesc]{Test Group} 140019.73 5 rv add [FillCount]{2} 140019.73 5 rv add [Token]{init} 140019.73 5 rv add [CallBackPhone]{6107365830} 140019.75 5 rv add [OutDial_ID]{1018} 140019.75 5 rv add [OutDial_OnNotConnected]{c:\toa\callout\UGI_trial\ugi_fax.vgs} 140019.75 5 rv add [OutDial_AnswerTimeout]{29} 140019.75 5 rv add [OutDial_RetriesLeft]{0} 140019.75 5 rv add [OutDial_PauseBetweenRetries]{5} 140019.75 5 dial making call tel[915708298973] ann[c:\toa\callout\UGI_trial\1651152.wav] vgs[c:\toa\callout\UGI_trial\ugi_trial1.vgs] am[c:\toa\callout\UGI_trial\ugi_trial1.vgs] OnHangup[C:\toa\callout\UGI_trial\ugi_onfinish.vgs] rv[[PhoneNumberCalled]{915708298973}[TOAID]{108}[JOBID]{41}[FirstName]{Jeremy}[LastName]{Boecker}[Jobdesc]{Test Group}[FillCount]{2}[Token]{init}[CallBackPhone]{6107365830}[OutDial_ID]{1018}[OutDial_OnNotConnected]{c:\toa\callout\UGI_trial\ugi_fax.vgs}[OutDial_AnswerTimeout]{29}[OutDial_RetriesLeft]{0}[OutDial_PauseBetweenRetries]{5}] 140019.75 5 script interpretor: VgMulti v6.0.3386 140019.77 5 state Dialing 915708298973 140019.77 5 lineMakeCall=>[] 140019.77 5 timer set 39 EV_TIMEOUT_MAKECALL_NORESPONSE 140020.31 5 tw DialogicEvent 135,TDX_SETHOOK,0,0,0,DX_OFFHOOK,CALL_OUTBOUND, 140020.31 5 event TDX_SETHOOK, iCode=135 state=5200 140020.31 5 LsWaitAfterDialingOut : 135,TDX_SETHOOK,0,0,0,DX_OFFHOOK,CALL_OUTBOUND, 140035.06 5 tw DialogicEvent 133,TDX_CALLP,11,0,0,CR_CEPT,, 140035.08 5 event OPERATOR, iCode=133 state=5200 140035.08 5 LsWaitAfterDialingOut : 133,OPERATOR,11,0,0,CR_CEPT,, 140035.08 5 event CR_CEPT, iCode=133 state=5200 140035.08 5 LsWaitAfterDialingOut : 133,CR_CEPT,11,0,0,,, 140035.08 5 event TDX_CALLP, iCode=133 state=5200 140035.08 5 LsWaitAfterDialingOut : 133,TDX_CALLP,11,0,0,CR_CEPT,, 140035.11 5 rvns add [OutDial_Result]{SIT_Unavailable} 140035.11 5 timer clear bForceClear=False 140035.11 5 OnNotConnected unknown app [c:\toa\callout\UGI_trial\ugi_fax.vgs] 140035.11 5 HangupCall start (CR_CEPT in LsWaitAfterDialingOut) 140035.11 5 rv add [Hangup Time]{7/28/2011 2:00:35 PM} 140035.13 5 state Hanging up call... [CR_CEPT in LsWaitAfterDialingOut] 140035.13 5 HangupCall_Common hCall=0 140035.13 5 play PlayStop ok 140035.13 5 timer set 1 EV_TIMEOUT_DOLINEDROP 140035.13 5 state Waiting for a call... 140035.13 5 fnHangupCall end 140035.13 5 tw DialogicEvent 134,TDX_CST,2909,0,0,DE_LCON,, 140035.13 5 event TDX_CST, iCode=134 state=900 140035.13 5 LsAwaitingCalls EV_UNKNOWN_134 140036.13 5 timer fired EV_TIMEOUT_DOLINEDROP 140036.13 5 event EV_TIMEOUT_DOLINEDROP, iCode=9102 state=900 140036.13 5 timer set 2 EV_TIMEOUT_WAITFORIDLEAFTERLINEDROP 140036.17 5 tw DialogicEvent 135,TDX_SETHOOK,0,0,0,DX_ONHOOK,, 140036.17 5 event TDX_SETHOOK, iCode=135 state=900 140036.17 5 LsAwaitingCalls EV_UNKNOWN_135 140036.17 5 event callstate IDLE 5 1,0,0 140036.17 5 WorkingMode@Idle= 140036.17 5 set LineState().hCall = 0 LineEvCallState-LINECALLSTATE_IDLE 140036.17 5 timer clear bForceClear=True 140036.19 5 LineState(iLineId).iVgsIdx = 0 140036.19 5 timer set 0.3 EV_TIMEOUT_TIMETOREINITLINE 140036.45 5 timer fired EV_TIMEOUT_TIMETOREINITLINE 140036.45 5 event EV_TIMEOUT_TIMETOREINITLINE, iCode=9008 state=900 140036.45 5 init atidle reinit : start 140036.45 5 init atidle reinit iConferenceOtherLegLid=-1 140036.45 5 init atidle reinit : reset all LineState variables 140036.45 5 timer set 2 EV_TIMEOUT_AFTERIDLE_ALLOWOUT 140036.45 5 state Waiting for a call... 140038.64 5 timer fired EV_TIMEOUT_AFTERIDLE_ALLOWOUT 140038.64 5 event EV_TIMEOUT_AFTERIDLE_ALLOWOUT, iCode=9013 state=900 140 Share this post Link to post
SupportTeam Report post Posted 08/31/2011 02:38 AM Trace shows that 15 seconds after dialing the number the Dialogic card reported hearing an 'operator intercept' tone on the line: 140035.06 5 tw DialogicEvent 133,TDX_CALLP,11,0,0,CR_CEPT,, Its unusual that the Dialogic card is reporting this tone if it is not played by Telco. a CEPT Tri-tone is not something that you see falsely detected. Maybe there were other sounds on the line when call is made? Was call routed though other services that could be playing tones? Do calls to this number always result in tri-tone being detected? When you dial this number yourself can you hear any telco tones played on the line before the call is connected? Can you check whether all the 'not-conected' calls are due to the CEPT Tri-tone, or do traces for other outbound calls show other causes? Share this post Link to post
ronghuizhang Report post Posted 08/31/2011 09:32 PM Dear VoiceGuide Support, Thanks for your quick reply. The phone is his desk phone in the company. He told me the problem only occurred to the company phone, not on his cellphone. So, he asked me if there is something on company's telephone system. I have no idea how to answer. The other case he gave me, the log said it's fax tone. But customer told me he did say 'yo' to the phone when he picked up. Any clue? See line: 142332.56 5 OnNotConnected unknown app [c:\toa\callout\UGI_trial\ugi_fax.vgs] 141318.78 2 LsAwaitingCalls 6 142010.75 0 sys cleanup Start 142010.75 0 sys cleanup End 142302.50 2 tw dtmf 7 (2,55,55) 142302.50 2 event 7, iCode=55 state=900 142302.50 2 LsAwaitingCalls 7 142302.73 2 tw dtmf 9 (2,57,57) 142302.73 2 event 9, iCode=57 state=900 142302.73 2 LsAwaitingCalls 9 142324.72 5 dial [1008,915708301274,1107251423,0,2359,MoTuWeThFrSaSu,[],1,c:\toa\callout\UGI_trial\1651152.wav,c:\toa\callout\UGI_trial\ugi_trial1.vgs,c:\toa\callout\UGI_trial\ugi_trial1.vgs,[PhoneNumberCalled]{915708301274}[TOAID]{100}[JOBID]{38}[FirstName]{Jeremy}[LastName]{Boecker}[Jobdesc]{Test Group}[FillCount]{2}[Token]{init}[CallBackPhone]{6107365830},29,0,5,c:\toa\callout\UGI_trial\ugi_fax.vgs,] (search started at 142324.72) 142324.72 5 dial DialOnLine start tel[915708301274] ann[c:\toa\callout\UGI_trial\1651152.wav] vgs[c:\toa\callout\UGI_trial\ugi_trial1.vgs] am[c:\toa\callout\UGI_trial\ugi_trial1.vgs] rv[[PhoneNumberCalled]{915708301274}[TOAID]{100}[JOBID]{38}[FirstName]{Jeremy}[LastName]{Boecker}[Jobdesc]{Test Group}[FillCount]{2}[Token]{init}[CallBackPhone]{6107365830}] cid[] 142324.72 0 dial callque update id=1008: NextCallTime=1107251428(7/25/2011 2:28:24 PM), RetriesLeft=-1 142324.73 5 rv clear all 142324.73 5 rv add [PhoneNumberCalled]{915708301274} 142324.73 5 rv add [TOAID]{100} 142324.73 5 rv add [JOBID]{38} 142324.73 5 rv add [FirstName]{Jeremy} 142324.73 5 rv add [LastName]{Boecker} 142324.73 5 rv add [Jobdesc]{Test Group} 142324.73 5 rv add [FillCount]{2} 142324.75 5 rv add [Token]{init} 142324.75 5 rv add [CallBackPhone]{6107365830} 142324.75 5 rv add [OutDial_ID]{1008} 142324.75 5 rv add [OutDial_OnNotConnected]{c:\toa\callout\UGI_trial\ugi_fax.vgs} 142324.75 5 rv add [OutDial_AnswerTimeout]{29} 142324.75 5 rv add [OutDial_RetriesLeft]{0} 142324.75 5 rv add [OutDial_PauseBetweenRetries]{5} 142324.75 5 dial making call tel[915708301274] ann[c:\toa\callout\UGI_trial\1651152.wav] vgs[c:\toa\callout\UGI_trial\ugi_trial1.vgs] am[c:\toa\callout\UGI_trial\ugi_trial1.vgs] OnHangup[C:\toa\callout\UGI_trial\ugi_onfinish.vgs] rv[[PhoneNumberCalled]{915708301274}[TOAID]{100}[JOBID]{38}[FirstName]{Jeremy}[LastName]{Boecker}[Jobdesc]{Test Group}[FillCount]{2}[Token]{init}[CallBackPhone]{6107365830}[OutDial_ID]{1008}[OutDial_OnNotConnected]{c:\toa\callout\UGI_trial\ugi_fax.vgs}[OutDial_AnswerTimeout]{29}[OutDial_RetriesLeft]{0}[OutDial_PauseBetweenRetries]{5}] 142324.75 5 script interpretor: VgMulti v6.0.3386 142324.77 5 state Dialing 915708301274 142324.77 5 lineMakeCall=>[] 142324.77 5 timer set 39 EV_TIMEOUT_MAKECALL_NORESPONSE 142325.31 5 tw DialogicEvent 135,TDX_SETHOOK,0,0,0,DX_OFFHOOK,CALL_OUTBOUND, 142325.31 5 event TDX_SETHOOK, iCode=135 state=5200 142325.31 5 LsWaitAfterDialingOut : 135,TDX_SETHOOK,0,0,0,DX_OFFHOOK,CALL_OUTBOUND, 142332.50 5 tw DialogicEvent 134,TDX_CST,191,0,0,DE_TONEON,FAX, 142332.50 5 event FAX, iCode=134 state=5200 142332.50 5 LsWaitAfterDialingOut : 134,FAX,191,0,0,DE_TONEON,FAX, 142332.52 5 event TDX_CST, iCode=134 state=5200 142332.52 5 LsWaitAfterDialingOut : 134,TDX_CST,191,0,0,DE_TONEON,FAX, 142332.52 5 tw DialogicEvent 133,TDX_CALLP,18,0,0,CR_FAXTONE,, 142332.52 5 event CR_FAXTONE, iCode=133 state=5200 142332.52 5 LsWaitAfterDialingOut : 133,CR_FAXTONE,18,0,0,,, 142332.52 5 event TDX_CALLP, iCode=133 state=5200 142332.52 5 LsWaitAfterDialingOut : 133,TDX_CALLP,18,0,0,CR_FAXTONE,, 142332.52 5 DialoutProcessFailedDial start sCalledFrom=[LsWaitAfterDialingOut-CR_FAXTONE] RetriesLeft=0 142332.56 5 rvns add [OutDial_Result]{Uncontactable_FaxAnswer} 142332.56 5 timer clear bForceClear=False 142332.56 5 OnNotConnected unknown app [c:\toa\callout\UGI_trial\ugi_fax.vgs] 142332.56 5 dial no escalation info 142332.56 5 HangupCall start (CR_FAXTONE in LsWaitAfterDialingOut) 142332.56 5 rv add [Hangup Time]{7/25/2011 2:23:32 PM} 142332.56 5 state Hanging up call... [CR_FAXTONE in LsWaitAfterDialingOut] 142332.56 5 HangupCall_Common hCall=0 142332.58 5 play PlayStop ok 142332.58 5 timer set 1 EV_TIMEOUT_DOLINEDROP 142332.58 5 state Waiting for a call... 142332.58 5 fnHangupCall end 142332.58 5 tw DialogicEvent 134,TDX_CST,65535,0,0,DE_LCON,, 142332.58 5 event TDX_CST, iCode=134 state=900 142332.58 5 LsAwaitingCalls EV_UNKNOWN_134 142333.56 5 timer fired EV_TIMEOUT_DOLINEDROP 142333.56 5 event EV_TIMEOUT_DOLINEDROP, iCode=9102 state=900 142333.56 5 timer set 2 EV_TIMEOUT_WAITFORIDLEAFTERLINEDROP 142333.61 5 tw DialogicEvent 135,TDX_SETHOOK,0,0,0,DX_ONHOOK,, 142333.61 5 event TDX_SETHOOK, iCode=135 state=900 142333.61 5 LsAwaitingCalls EV_UNKNOWN_135 142333.61 5 event callstate IDLE 5 1,0,0 142333.61 5 WorkingMode@Idle= 142333.61 5 set LineState().hCall = 0 LineEvCallState-LINECALLSTATE_IDLE 142333.61 5 timer clear bForceClear=True 142333.61 5 LineState(iLineId).iVgsIdx = 0 142333.61 5 timer set 0.3 EV_TIMEOUT_TIMETOREINITLINE 142333.89 5 timer fired EV_TIMEOUT_TIMETOREINITLINE 142333.89 5 event EV_TIMEOUT_TIMETOREINITLINE, iCode=9008 state=900 142333.89 5 init atidle reinit : start 142333.89 5 init atidle reinit iConferenceOtherLegLid=-1 142333.89 5 init atidle reinit : reset all LineState variables 142333.89 5 timer set 2 EV_TIMEOUT_AFTERIDLE_ALLOWOUT 142333.89 5 state Waiting for a call... 142336.08 5 timer fired EV_TIMEOUT_AFTERIDLE_ALLOWOUT 142336.08 5 event EV_TIMEOUT_AFTERIDLE_ALLOWOUT, iCode=9013 state=900 Share this post Link to post
SupportTeam Report post Posted 09/03/2011 02:36 AM He told me the problem only occurred to the company phone, Sounds like his company's phone system is at some stage routed over a poor quality connection. Poor quality connections can sometimes significantly distort the voice. This can happen is voice is transmitted over VoIP type network that has had not been designed/configured to guarantee quality connections. BTW. the 'OnNotConnected' script should be a .VGS/.BAT/.EXE/.COM etc type script. Not a VoiceGuide script. That is why you are seeing: OnNotConnected unknown app [c:\toa\callout\UGI_trial\ugi_fax.vgs] Share this post Link to post