Timeout Path Not Taken

[jacksors]

I had a previous post open, but just had so many configuration problems and such, I decided to wipe my system and start fresh. The fresh install has yield some different yet some of the same results.

 

System Specs:

Windows XP SP2

D/4PCIU Card

Installed VG using Standard/TAPI selection and applied VG for Dialogic Patch.

I will attach my script, configuration and log files.

 

My script does the following:

Scenario 1:

1. Makes an announced transfer to an external number. VG successfully issues a hookflash(places call on hold), then dials a 9 (to access outside line) then the phone number. The module is set with a fail and timeout path of 40. However, after 30 seconds VG automatically takes the fail path.

2. On fail path, VG successfully issues a hookflash to remove call from hold and goes to next transfer module. The call is once again placed on hold and a 9 and phone number are dialed. Once again, this module has a fail and timeout of 40 specified. The timeout setting is never taken. After 30 seconds the call takes the fail path to voice mail.

 

Question 1:

I need to know why the timeout path is never taken.

 

Scenario 2:

1. Same as above, accept this time, the 1st number being dialed is busy. I do not have a busy path specified in my module, but VG takes the fail path after 30 seconds.

2. As you can see by the logs, it appears that VG successfully issues the hookflash to remove the call from hold, then goes through 2 modules before the next transfer call module, then attempts to make the transfer and hangs up with out doing a thing.

 

Question 2:

Why is VG hanging up this time? The caller is still on the line. The hookflash to retrieve the call from hold when party1 does not answer worked successfully in scenario 1 but not scenario 2.

 

Thanks.

logs.zip

[jacksors]

Weird quark. Since posting this, I have made several more tests. The first transfer that my script attempts to make is now waiting the full 40 seconds before it fails. However, the second module is still timing out at 30. And still does not properly maintain call when busy signal is detected.

Timeout_worked.zip

[jacksors]

Any update on why VG is not following its own timeout guidelines/rules?

[SupportTeam]

Trace in Timeout_worked.zip shows an Announced Transfer being made to 9,7983679, which timed out after 40 seconds of it not being answered and then was retrieved using a hookflash.

172712.73   1       timeout on transfer attempt set by timeout path (40 sec)

172712.77   1 state [TransfertoTechnician] Announced Hookflash Transfer to 9,7983679

...

172753.56   1 xfer  timed out awaiting for response from call recipient

172753.58   1 xfer  dial !

 

The script the goes on to next Announced Transfer module, and makes a call to 9,3611511. The 40 second timeout is set as well:

172803.63   1       timeout on transfer attempt set by timeout path (40 sec)

172803.66   1 state [backupTechTransfer] Announced Hookflash Transfer to 9,3611511

The Dialogic card hears a human answer the call about 20 seconds after the start of transfer:

172824.95   1 tw    DialogicEvent 133,TDX_CALLP,10,3,0,TDX_CALLP,CR_CNCT,CON_PVD

So VoiceGuide starts playing the "Would you like to accept this call?" message:

172825.13   1 cl    Play_Start C:\IVR\system\voice\TsfrCallFrom.wav,,C:\IVR\system\voice\TsfrAskAccept.wav

and the recipient of the call presses "1" to accept the call about 5 seconds later.

172829.16   1 tw    dtmf 1   (1,49,49)

172829.17   1 rv    add [backupTechTransfer]{1}

VoiceGuide then looks if it should go down any of the paths, and since none are defined it just hangs up:

172829.33   1       path {CON_PVD} not found

172829.33   1       path {PVD} not found

172829.33   1       path {voice} not found

172829.34   1       True  path not defined - hangup call (iXferType=13)

NB. The VoiceGuide line would have to hang up to connect the other two lines together, so if you are going to use any of the above 4 paths to do something after the connection has completed make sure it does not take too long, so hat script can quickly complete, hangup, and the two caller are connected.

 

 

The trace shows system timing out correctly on first attempt and correctly transferring to the second number. The problems you describe in your post are not visible in this trace.

[SupportTeam]

In trace logs.zip we see an Announced Transfer being made to 9,7983679 and the timeout being set to 40 seconds as well, but as the number never starts ringing then the "No Ringback" event fires and VoiceGuide takes back the call and looks for paths CR_NORB and "noringback" which are not found so the "Fail" path is taken:

170816.75   1 state [TransfertoTechnician] Announced Hookflash Transfer to 9,7983679

...

170819.64   1 timer set 40  EV_TIMEOUT_ANNOUNCED_TRANSFER_ATTEMPT_TOOK_TOO_LONG

...

170842.80   1 tw    DialogicEvent 133,TDX_CALLP,9,0,0,CR_NORB,,

...

170843.53   1       path {CR_NORB} not found

170843.53   1       path {noringback} not found

170843.53   1       going down False path (iXferType=13) state:LsXferCallRejected

Then VoiceGuide makes an Announced Transfer call to 9,3611511. The timeout is set to 40 seconds. The call is accepted by recipient of transfer call. VoiceGuide then looks if it should go down any of the paths, and since none are defined it just hangs up:

170852.92   1 state [backupTechTransfer] Announced Hookflash Transfer to 9,3611511

...

170855.84   1 timer set 40  EV_TIMEOUT_ANNOUNCED_TRANSFER_ATTEMPT_TOOK_TOO_LONG

...

170918.73   1       LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 133,CON_PVD,10,3,0,CR_CNCT,CON_PVD,CON_PVD

...

170921.28   1 tw    dtmf 1   (1,49,49)

170921.30   1 rv    add [backupTechTransfer]{1}

...

170921.44   1       path {CON_PVD} not found

170921.45   1       path {PVD} not found

170921.45   1       path {voice} not found

170921.45   1       True  path not defined - hangup call (iXferType=13)

 

 

In second call in trace logs.zip we see a transfer being made to 9,7983679 and a 40 second timeout set:

171022.22   1 state [TransfertoTechnician] Announced Hookflash Transfer to 9,7983679

...

171025.17   1 timer set 40  EV_TIMEOUT_ANNOUNCED_TRANSFER_ATTEMPT_TOOK_TOO_LONG

Busy tone is detected an call is retrieved and "Fail" path is taken to module [OnHold2], but call is disconnected as the PBX dropped loop current.:

171038.81   1 tw    DialogicEvent 133,TDX_CALLP,7,0,0,CR_BUSY,,

171038.81   1       LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 133,TDX_CALLP,7,0,0,CR_BUSY,,

171038.83   1 xfer  dial !

...

171039.52   1       path {CR_BUSY} not found

171039.53   1       path {BUSY} not found

171039.53   1       going down False path (iXferType=13) state:LsXferCallRejected

 

171039.83   1 state [OnHold2] Playing

171039.84   1 state [OnHold2] Playing (Sound\onhold1.wav)

171039.88   1 tw    ConvertWav2Vox C:\Sound\onhold1.wav

171039.88   1 timer clear

171039.95   1 tw    wav->vox convert end 969421,C:\Sound\onhold1.vox,1,0,,

171039.95   1 play  start ok, lPlayId=969500

171040.02   1 event callstate DISCONNECTED 1 0 0

171040.02   1 event EV_REMOTEPARTY_DISCONNECT, code=9250, state=1100

171040.03   1       LsPlayMsg EV_REMOTEPARTY_DISCONNECT,EV_REMOTEPARTY_DISCONNECT

171040.03   1       path {EV_REMOTEPARTY_DISCONNECT} not found

171040.03   1 rv    add [Hangup Time]{5/13/2005 5:10:40 PM}

171040.05   1 state Hanging up call...

 

171040.015 001 ev    TDX_CST (CST Event Received)

171040.015 001 ev    TDX_CST DE_LCOF data=3465

171040.015 001 te    LINE_CALLSTATE(1, 0x1, 0x4000, 0x0, 0x0) LINE_CALLSTATE-LINECALLSTATE_DISCONNECTED-DE_LCOF

This is same problem as we have identified before in a different thread - you should see why the PBX is dropping loop current upon a transfer to a busy extension.

 

Looks like the PBX is trying to signal to us that the extension is busy be using loop current drop signal - but the VoiceGuide software uses loop current drop to indicate end of call (that's what loop current drop usually is used to signal).

 

As mentioned before, we will soon supply a version of VG for Dialogic that can ignore loop current drop.

[jacksors]

I changed my transfer module to be a monitored hookflash instead of an announced transfer. Tried transferring the call to a cell phone. Made two calls to the IVR system back to back.

 

Both times the cell phone rang. The first time, the cell rang about 5 times then went to voicemail. VG saw that as a response and transferred it to the cell's VM. The exact action I wanted.

 

Call 2, the cell phone only rang 2 times before VG continued on with the rest of the script. Based on the log files it looks like there was one ring back, then VG issued a {noringback} found and continued on with the rest of the script.

 

Can you offer an explanation for this behavior?

results.txt

[jacksors]

Ok, after working with the vendor, I think we may have a solution, just need a little more configuration help.

 

We modified our PBX to use a menu assisted transfer option. When making calls, my transfer call module now needs to be setup like this (#,9,PhoneNumber). This works, VG is successfully able to make calls. And, in the few tests I have done has detected the busy signal and gone down the busy path.

 

My problem is retrieving the call from hold. When a hookflash is issued to retrieve the call from hold, there is a 3-4 second pause followed by a menu asking the caller what they want to do with the onhold call.

 

What I need to do is be able to issue this command (,,,,4 (where 4 is the number that reconnects IVR to the caller)). When working with just the phone system this works great!! How do I accomplish this through the VG script????

 

I have read that a play module can be setup to issue a set of commands and then continue on with the script. Please provide instruction on how to setup a play module (or whatever is needed) to allow me to retrieve this call from hold. Thank you.

[SupportTeam]

What I need to do is be able to issue this command (,,,,4 (where 4 is the number that reconnects IVR to the caller)). When working with just the phone system this works great!! How do I accomplish this through the VG script????

In Script Designer go to "Edit"->"PBX Command Strings" and change the Retrieve Call setting to be !,,,,4

[jacksors]

Great, thanks. That resolved the problem. VG is working much better now with one exception.

 

It is falsely detecting a no ring back on the line. When doing any type of transfer (monitored or announced), the dialed number will ring up to 3 times before VG decides that there was no ring back and continue down the false path of the module. However, if the person answered their phone within those 3 rings, the call is successfully transfered.

 

Please review attached log files. Is there a way I can configure VG to wait a longer period of time before it decides there is no ring back? Or configure VG so that it realizes the number is actually ringing?

 

This was working a few days ago, the module would always follow the timeout path. I changed the PBX Strings to change how VG puts calls on hold but that is it.

 

 

 

Under PBX Strings there is an option to specify the characters for completing an anounced call. I modified that value and now VG is transferring the call. However, Blind transfers are not working. The call gets placed on hold and the number gets dialed, but VG hangs up on the person who made the call. Where can I supply settings on how VG should retrieve calls from hold for a blind transfer?

[jacksors]

What could be causing VG's tempermental behavior. On occasion, VG does not properly handle the call. I placed two calls to the system with in seconds of each other and VG handled each one differently.

 

 

Here it incorrectly detected a no ring back and transfered the call to VM, however the caller did not hear the VM greeting just an empty tone:

 

130605.30 1 event EV_TIMEOUT_Transfer_Prefix_PauseAfter, code=9030, state=1902

130605.30 1 LsXfer_2_OnEndHook1PlayDestNbr 9030,EV_TIMEOUT_Transfer_Prefix_PauseAfter,0,0,0,,,

130605.31 1 Dial(1,9,3611511, cp on) call

130605.31 1 Dial(1,9,3611511) ok

130605.33 1 timer set 50 EV_TIMEOUT_ANNOUNCED_TRANSFER_ATTEMPT_TOOK_TOO_LONG

130622.75 1 tw DialogicEvent 134,TDX_CST,199,0,0,DE_TONEON,TID_RNGBK1,

130622.75 1 event RINGBACK, code=134, state=1903

130622.77 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,RINGBACK,199,0,0,DE_TONEON,TID_RNGBK1,

130622.77 1 event TID_RNGBK1, code=134, state=1903

130622.78 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TID_RNGBK1,199,0,0,DE_TONEON,TID_RNGBK1,

130622.78 1 event TDX_CST, code=134, state=1903

130622.78 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TDX_CST,199,0,0,DE_TONEON,TID_RNGBK1,

130629.38 1 tw DialogicEvent 134,TDX_CST,200,0,0,DE_TONEON,TID_RNGBK2,

130629.38 1 event RINGBACK, code=134, state=1903

130629.39 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,RINGBACK,200,0,0,DE_TONEON,TID_RNGBK2,

130629.39 1 event TID_RNGBK2, code=134, state=1903

130629.39 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TID_RNGBK2,200,0,0,DE_TONEON,TID_RNGBK2,

130629.41 1 event TDX_CST, code=134, state=1903

130629.41 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TDX_CST,200,0,0,DE_TONEON,TID_RNGBK2,

130630.63 1 tw DialogicEvent 133,TDX_CALLP,9,0,0,CR_NORB,,

130630.63 1 event TDX_CALLP, code=133, state=1903

130630.64 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 133,TDX_CALLP,9,0,0,CR_NORB,,

130630.64 1 xfer dial !,,4

130635.25 1 tw PlayEnd 1 0

130635.27 1 play end id=0, (current ID)

130635.27 1 event EV_PLAY_FINISHED, code=8001, state=1906

130635.27 1 LsXfer_5B : 8001(EV_PLAY_FINISHED),EV_PLAY_FINISHED,0,0,0,,,

130635.28 1 tw DialogicEvent 132,TDX_DIAL,0,0,0,,,

130635.28 1 event TDX_DIAL, code=132, state=1906

130635.31 1 LsXfer_5B : 132(EV_UNKNOWN_132),TDX_DIAL,0,0,0,,,

130635.31 1 sXferDialResult_SuccOrFail=

130635.33 1 path {CR_NORB} not found

130635.33 1 path {noringback} not found

130635.34 1 going down False path (iXferType=12) state:LsXferCallRejected

130635.34 1 timer clear

130635.36 1 RunVmModule called when running Scripted VM

130635.36 1 timer clear

 

Seconds later, another call was placed. This time, VG monitored that the cell phone VM picked up and transferred the call:

 

130732.61 1 LsXfer_2_OnEndHook1PlayDestNbr 9030,EV_TIMEOUT_Transfer_Prefix_PauseAfter,0,0,0,,,

130732.63 1 Dial(1,9,3611511, cp on) call

130732.63 1 Dial(1,9,3611511) ok

130732.63 1 timer set 50 EV_TIMEOUT_ANNOUNCED_TRANSFER_ATTEMPT_TOOK_TOO_LONG

130750.05 1 tw DialogicEvent 134,TDX_CST,200,0,0,DE_TONEON,TID_RNGBK2,

130750.05 1 event RINGBACK, code=134, state=1903

130750.06 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,RINGBACK,200,0,0,DE_TONEON,TID_RNGBK2,

130750.06 1 event TID_RNGBK2, code=134, state=1903

130750.08 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TID_RNGBK2,200,0,0,DE_TONEON,TID_RNGBK2,

130750.08 1 event TDX_CST, code=134, state=1903

130750.08 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TDX_CST,200,0,0,DE_TONEON,TID_RNGBK2,

130808.00 1 tw DialogicEvent 134,TDX_CST,199,0,0,DE_TONEON,TID_RNGBK1,

130808.00 1 event RINGBACK, code=134, state=1903

130808.02 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,RINGBACK,199,0,0,DE_TONEON,TID_RNGBK1,

130808.02 1 event TID_RNGBK1, code=134, state=1903

130808.02 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TID_RNGBK1,199,0,0,DE_TONEON,TID_RNGBK1,

130808.03 1 event TDX_CST, code=134, state=1903

130808.03 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TDX_CST,199,0,0,DE_TONEON,TID_RNGBK1,

130809.97 1 tw DialogicEvent 133,TDX_CALLP,10,1,0,TDX_CALLP,CR_CNCT,CON_CAD

130809.98 1 event CON_CAD, code=133, state=1903

130809.98 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 133,CON_CAD,10,1,0,CR_CNCT,CON_CAD,CON_CAD

130809.98 1 event TDX_CALLP, code=133, state=1903

130810.00 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 133,TDX_CALLP,10,1,0,CR_CNCT,CON_CAD,CON_CAD

130810.00 1 LsXfer_3 CR_CNCT on an XT_HOOK_MONITORED

130810.02 1 xfer dial !,2

130812.64 1 tw PlayEnd 1 0

130812.64 1 play end id=0, (current ID)

130812.66 1 event EV_PLAY_FINISHED, code=8001, state=1905

130812.66 1 LsXfer_5A : 8001(EV_PLAY_FINISHED),EV_PLAY_FINISHED,0,0,0,,,

130812.67 1 tw DialogicEvent 132,TDX_DIAL,0,0,0,,,

130812.67 1 event TDX_DIAL, code=132, state=1905

130812.67 1 LsXfer_5A : 132(EV_UNKNOWN_132),TDX_DIAL,0,0,0,,,

130812.69 1 sXferDialResult_SuccOrFail=

130812.69 1 rv add [Hangup Time]{5/17/2005 1:08:12 PM}

130812.69 1 state Hanging up call... [LsXfer_5A]

130812.70 1 HangupCall_Common hCall=1

130812.70 1 rec RecSoundStop ok

 

I need it to do this everytime.

logs.zip

[jacksors]

I have been running extensive tests on the script (in particular the monitored hookflash transfer to a cell number) and just keep getting very sparatic results.

 

The excerpt below shows that there was a hook monitored on the line and the call was transferred. The caller heard one ring then the call when to the cell voicemail. Good result, but the hook was monitored before the VM greeting kicked in:

 

32702.41 1 tw PlayEnd 1 0

132702.42 1 play end id=0, (current ID)

132702.42 1 event EV_PLAY_FINISHED, code=8001, state=1902

132702.42 1 LsXfer_2_OnEndHook1PlayDestNbr 8001,EV_PLAY_FINISHED,0,0,0,,,

132702.42 1 tw DialogicEvent 132,TDX_DIAL,0,0,0,,,

132702.42 1 event TDX_DIAL, code=132, state=1902

132702.42 1 LsXfer_2_OnEndHook1PlayDestNbr 132,TDX_DIAL,0,0,0,,,

132702.44 1 VG.INI [PBX] Transfer_Prefix_PauseAfter = 2 sec

132702.44 1 timer set 2 EV_TIMEOUT_Transfer_Prefix_PauseAfter

132704.59 1 timer fired EV_TIMEOUT_Transfer_Prefix_PauseAfter

132704.59 1 event EV_TIMEOUT_Transfer_Prefix_PauseAfter, code=9030, state=1902

132704.59 1 LsXfer_2_OnEndHook1PlayDestNbr 9030,EV_TIMEOUT_Transfer_Prefix_PauseAfter,0,0,0,,,

132704.59 1 Dial(1,9,3611511, cp on) call

132704.59 1 Dial(1,9,3611511) ok

132704.61 1 timer set 50 EV_TIMEOUT_ANNOUNCED_TRANSFER_ATTEMPT_TOOK_TOO_LONG

132721.92 1 tw DialogicEvent 134,TDX_CST,199,0,0,DE_TONEON,TID_RNGBK1,

132721.92 1 event RINGBACK, code=134, state=1903

132721.92 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,RINGBACK,199,0,0,DE_TONEON,TID_RNGBK1,

132721.92 1 event TID_RNGBK1, code=134, state=1903

132721.92 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TID_RNGBK1,199,0,0,DE_TONEON,TID_RNGBK1,

132721.92 1 event TDX_CST, code=134, state=1903

132721.94 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TDX_CST,199,0,0,DE_TONEON,TID_RNGBK1,

132735.89 1 tw DialogicEvent 133,TDX_CALLP,10,1,0,TDX_CALLP,CR_CNCT,CON_CAD

132735.89 1 event CON_CAD, code=133, state=1903

132735.89 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 133,CON_CAD,10,1,0,CR_CNCT,CON_CAD,CON_CAD

132735.89 1 event TDX_CALLP, code=133, state=1903

132735.91 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 133,TDX_CALLP,10,1,0,CR_CNCT,CON_CAD,CON_CAD

132735.91 1 LsXfer_3 CR_CNCT on an XT_HOOK_MONITORED

132735.91 1 xfer dial !,2

132738.52 1 tw PlayEnd 1 0

132738.52 1 play end id=0, (current ID)

132738.52 1 event EV_PLAY_FINISHED, code=8001, state=1905

132738.52 1 LsXfer_5A : 8001(EV_PLAY_FINISHED),EV_PLAY_FINISHED,0,0,0,,,

132738.52 1 tw DialogicEvent 132,TDX_DIAL,0,0,0,,,

132738.53 1 event TDX_DIAL, code=132, state=1905

132738.53 1 LsXfer_5A : 132(EV_UNKNOWN_132),TDX_DIAL,0,0,0,,,

132738.53 1 sXferDialResult_SuccOrFail=

132738.53 1 rv add [Hangup Time]{5/17/2005 1:27:38 PM}

132738.53 1 state Hanging up call... [LsXfer_5A]

132738.53 1 HangupCall_Common hCall=1

132738.55 1 rec RecSoundStop ok

 

 

Here we can see that VG incorrectly detected a no ring back on the line followed the false path to the VM module. However, the caller never heard anything and the cell number dialed kept ringing:

 

132551.41 1 tw PlayEnd 1 0

132551.42 1 play end id=0, (current ID)

132551.42 1 event EV_PLAY_FINISHED, code=8001, state=1902

132551.42 1 LsXfer_2_OnEndHook1PlayDestNbr 8001,EV_PLAY_FINISHED,0,0,0,,,

132551.42 1 tw DialogicEvent 132,TDX_DIAL,0,0,0,,,

132551.42 1 event TDX_DIAL, code=132, state=1902

132551.42 1 LsXfer_2_OnEndHook1PlayDestNbr 132,TDX_DIAL,0,0,0,,,

132551.44 1 VG.INI [PBX] Transfer_Prefix_PauseAfter = 2 sec

132551.44 1 timer set 2 EV_TIMEOUT_Transfer_Prefix_PauseAfter

132553.55 1 timer fired EV_TIMEOUT_Transfer_Prefix_PauseAfter

132553.55 1 event EV_TIMEOUT_Transfer_Prefix_PauseAfter, code=9030, state=1902

132553.55 1 LsXfer_2_OnEndHook1PlayDestNbr 9030,EV_TIMEOUT_Transfer_Prefix_PauseAfter,0,0,0,,,

132553.55 1 Dial(1,9,3611511, cp on) call

132553.55 1 Dial(1,9,3611511) ok

132553.55 1 timer set 50 EV_TIMEOUT_ANNOUNCED_TRANSFER_ATTEMPT_TOOK_TOO_LONG

132616.91 1 tw DialogicEvent 134,TDX_CST,199,0,0,DE_TONEON,TID_RNGBK1,

132616.92 1 event RINGBACK, code=134, state=1903

132616.92 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,RINGBACK,199,0,0,DE_TONEON,TID_RNGBK1,

132616.92 1 event TID_RNGBK1, code=134, state=1903

132616.92 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TID_RNGBK1,199,0,0,DE_TONEON,TID_RNGBK1,

132616.92 1 event TDX_CST, code=134, state=1903

132616.92 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TDX_CST,199,0,0,DE_TONEON,TID_RNGBK1,

132618.86 1 tw DialogicEvent 133,TDX_CALLP,9,0,0,CR_NORB,,

132618.86 1 event TDX_CALLP, code=133, state=1903

132618.86 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 133,TDX_CALLP,9,0,0,CR_NORB,,

132618.86 1 xfer dial !,,4

132623.47 1 tw PlayEnd 1 0

132623.48 1 play end id=0, (current ID)

132623.48 1 event EV_PLAY_FINISHED, code=8001, state=1906

132623.48 1 LsXfer_5B : 8001(EV_PLAY_FINISHED),EV_PLAY_FINISHED,0,0,0,,,

132623.48 1 tw DialogicEvent 132,TDX_DIAL,0,0,0,,,

132623.48 1 event TDX_DIAL, code=132, state=1906

132623.48 1 LsXfer_5B : 132(EV_UNKNOWN_132),TDX_DIAL,0,0,0,,,

132623.50 1 sXferDialResult_SuccOrFail=

132623.50 1 path {CR_NORB} not found

132623.50 1 path {noringback} not found

132623.50 1 going down False path (iXferType=12) state:LsXferCallRejected

132623.50 1 timer clear

132623.50 1 RunVmModule called when running Scripted VM

132623.52 1 timer clear

132623.52 1 voicemail used: Scripted

 

Here we can see that the cell vm box picked up and VG interpreted that as a hook and transferred the call. In my 10 test dials this happened 4 times. Not a very good percentage:

 

132437.19 1 LsXfer_2_OnEndHook1PlayDestNbr 9030,EV_TIMEOUT_Transfer_Prefix_PauseAfter,0,0,0,,,

132437.19 1 Dial(1,9,3611511, cp on) call

132437.19 1 Dial(1,9,3611511) ok

132437.19 1 timer set 50 EV_TIMEOUT_ANNOUNCED_TRANSFER_ATTEMPT_TOOK_TOO_LONG

132454.81 1 tw DialogicEvent 134,TDX_CST,200,0,0,DE_TONEON,TID_RNGBK2,

132454.81 1 event RINGBACK, code=134, state=1903

132454.81 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,RINGBACK,200,0,0,DE_TONEON,TID_RNGBK2,

132454.81 1 event TID_RNGBK2, code=134, state=1903

132454.83 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TID_RNGBK2,200,0,0,DE_TONEON,TID_RNGBK2,

132454.83 1 event TDX_CST, code=134, state=1903

132454.83 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TDX_CST,200,0,0,DE_TONEON,TID_RNGBK2,

132500.56 1 tw DialogicEvent 134,TDX_CST,199,0,0,DE_TONEON,TID_RNGBK1,

132500.58 1 event RINGBACK, code=134, state=1903

132500.58 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,RINGBACK,199,0,0,DE_TONEON,TID_RNGBK1,

132500.58 1 event TID_RNGBK1, code=134, state=1903

132500.58 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TID_RNGBK1,199,0,0,DE_TONEON,TID_RNGBK1,

132500.58 1 event TDX_CST, code=134, state=1903

132500.59 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TDX_CST,199,0,0,DE_TONEON,TID_RNGBK1,

132514.55 1 tw DialogicEvent 133,TDX_CALLP,10,1,0,TDX_CALLP,CR_CNCT,CON_CAD

132514.55 1 event CON_CAD, code=133, state=1903

132514.55 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 133,CON_CAD,10,1,0,CR_CNCT,CON_CAD,CON_CAD

132514.55 1 event TDX_CALLP, code=133, state=1903

132514.55 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 133,TDX_CALLP,10,1,0,CR_CNCT,CON_CAD,CON_CAD

132514.56 1 LsXfer_3 CR_CNCT on an XT_HOOK_MONITORED

132514.56 1 xfer dial !,2

132517.17 1 tw PlayEnd 1 0

132517.17 1 play end id=0, (current ID)

132517.17 1 event EV_PLAY_FINISHED, code=8001, state=1905

132517.17 1 LsXfer_5A : 8001(EV_PLAY_FINISHED),EV_PLAY_FINISHED,0,0,0,,,

132517.17 1 tw DialogicEvent 132,TDX_DIAL,0,0,0,,,

132517.17 1 event TDX_DIAL, code=132, state=1905

132517.19 1 LsXfer_5A : 132(EV_UNKNOWN_132),TDX_DIAL,0,0,0,,,

132517.19 1 sXferDialResult_SuccOrFail=

132517.19 1 rv add [Hangup Time]{5/17/2005 1:25:17 PM}

132517.19 1 state Hanging up call... [LsXfer_5A]

132517.19 1 HangupCall_Common hCall=1

 

Once again we see where VG incorrectly interpretted a no ring back:

 

132204.70 1 LsXfer_2_OnEndHook1PlayDestNbr 9030,EV_TIMEOUT_Transfer_Prefix_PauseAfter,0,0,0,,,

132204.70 1 Dial(1,9,3611511, cp on) call

132204.70 1 Dial(1,9,3611511) ok

132204.70 1 timer set 50 EV_TIMEOUT_ANNOUNCED_TRANSFER_ATTEMPT_TOOK_TOO_LONG

132229.03 1 tw DialogicEvent 134,TDX_CST,199,0,0,DE_TONEON,TID_RNGBK1,

132229.03 1 event RINGBACK, code=134, state=1903

132229.03 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,RINGBACK,199,0,0,DE_TONEON,TID_RNGBK1,

132229.03 1 event TID_RNGBK1, code=134, state=1903

132229.03 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TID_RNGBK1,199,0,0,DE_TONEON,TID_RNGBK1,

132229.03 1 event TDX_CST, code=134, state=1903

132229.05 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 134,TDX_CST,199,0,0,DE_TONEON,TID_RNGBK1,

132230.02 1 tw DialogicEvent 133,TDX_CALLP,9,0,0,CR_NORB,,

132230.03 1 event TDX_CALLP, code=133, state=1903

132230.03 1 LsXfer_3_AfterDialDestNbrWaitForCallProgInfo 133,TDX_CALLP,9,0,0,CR_NORB,,

132230.03 1 xfer dial !,,4

132234.64 1 tw PlayEnd 1 0

132234.64 1 play end id=0, (current ID)

132234.64 1 event EV_PLAY_FINISHED, code=8001, state=1906

132234.64 1 LsXfer_5B : 8001(EV_PLAY_FINISHED),EV_PLAY_FINISHED,0,0,0,,,

132234.66 1 tw DialogicEvent 132,TDX_DIAL,0,0,0,,,

132234.66 1 event TDX_DIAL, code=132, state=1906

132234.66 1 LsXfer_5B : 132(EV_UNKNOWN_132),TDX_DIAL,0,0,0,,,

132234.66 1 sXferDialResult_SuccOrFail=

132234.66 1 path {CR_NORB} not found

132234.66 1 path {noringback} not found

132234.67 1 going down False path (iXferType=12) state:LsXferCallRejected

132234.67 1 timer clear

132234.67 1 RunVmModule called when running Scripted VM

 

Logs attached.

Logs.zip

[jacksors]

Its been awhile, any update on this?

[SupportTeam]

You have started a new thread on the "False Ringback detection" subject here: http://voiceguide.com/forums/index.php?showtopic=2850 so all new answers where in that thread.

 

Please place any new posts you have in one thread only (the new one mentioned above).