Hi,

We are facing below error at frequent basis on MPP log:

2013-07-14 10:53:52,592|24575|LogManager.cpp:2692:Error(Unhandled exception (suspected infinite loop))
2013-07-14 10:53:52,864|24575|LogManager.cpp:2692:VXML Parse error(Parse error in http://172.30.132.74:7003/Unit198/AvayaSessionTerminationServlet?___DDSESSIONID=yhhvRvzchWLQZ9L4cFHyhnj2HGhrG81n2h8yWgFnRLq4Twzr13V7%21-1774906882%211373778812093%3A%2FUnit198 at line: 1 column: 1 description: Invalid document structure)
2013-07-14 10:54:40,015|25972|LogManager.cpp:2692:Error(Unhandled exception (suspected infinite loop))
2013-07-14 10:54:40,126|25972|LogManager.cpp:2692:VXML Parse error(Parse error in http://172.30.132.74:7003/unitCallRouter/AvayaSessionTerminationServlet?___DDSESSIONID=lTvCRv0VfhkY9rSlg3PpdslYCQJJP4S0kW2Q71y3bsf8hmpJXpht%21-1774906882%211373778965550%3A%2FunitCallRouter at line: 1 column: 1 description: Invalid document structure)
2013-07-14 11:00:21,279|29617|LogManager.cpp:2692:Error(Unhandled exception (suspected infinite loop))


Please help us is identifying the issue.

Thanks:
Satendra

Can you post the application log with VXML output enabled that generated this error?

Hi Neil,

We have enabled the vxml log from application side now. Will share the same.

At application trace log we can see only badfetch error. This error is shown at MPP log along with badfetch http 500 error.

We are facing this issue frequently at random time and at random nodes(Wherever we are playing out any prompt i.e. Menu/Announcement/Prompt & collect node).

Will share collect the logs for 2 hours and put some error cases here.

Thanks:
Satendra

Hi Neil,

As communicated in my last mail,in application trace log we are able to see only bad fetch error at frequent basis. I've collected 1 badfetch while playing out prompts:

19/07/2013 21:08:24:642 INFO - KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm!-1814558751!1374248292256:/unitCallRouter : Using SCESession KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm!-1814558751!1374248292256:/unitCallRouter servlet : unitSubflowLangSel-playVXML
19/07/2013 21:08:24:642 INFO - KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm!-1814558751!1374248292256:/unitCallRouter : Using SCESession KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm!-1814558751!1374248292256:/unitCallRouter servlet : subPlayVXMLAudio-Begin
19/07/2013 21:08:24:642 INFO - KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm!-1814558751!1374248292256:/unitCallRouter : Using SCESession KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm!-1814558751!1374248292256:/unitCallRouter servlet : subPlayVXMLAudio-playVxml
19/07/2013 21:08:24:643 DEBUG - KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm!-1814558751!1374248292256:/unitCallRouter : *** Reply for [/unitPrepaid/subPlayVXMLAudio-playVxml] ***
19/07/2013 21:08:24:643 DEBUG - KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm!-1814558751!1374248292256:/unitCallRouter : 0:<?xml version="1.0" encoding="UTF-8"?>
1:<vxml version="2.1" xmlns="http://www.w3.org/2001/vxml" xml:lang="en-us">
2:<meta name="author" content="Avaya Dialog Designer"/>
3:<meta name="runtime-version" content="05.01.17.02"/>
4:<meta name="runtimecommon-version" content="05.01.17.02"/>
5:<meta name="copyright" content="Copyright (c) 2002-2010, Avaya"/>
6:<form id="playVxml">
7:<block>
8:<audio src='http://172.24.141.24/Unitech/Audio/engl/GUJA_1.wav'/>
9:<audio src='http://172.24.141.24/Unitech/Audio/engl/HIND_2.wav'/>
10:<audio src='http://172.24.141.24/Unitech/Audio/engl/ENGL_3.wav'/>
11:<audio src='http://172.24.141.24/Unitech/Audio/engl/062.wav'/>
12:</block>
13:<block>
14:<submit next="subPlayVXMLAudio-vxmlReturn?___DDSESSIONID=KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm%21-1814558751%211374248292256%3A%2FunitCallRouter"/>
15:</block>
16:</form>
17:</vxml>
18:

19/07/2013 21:08:44:736 INFO - KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm!-1814558751!1374248292256:/unitCallRouter : Using SCESession KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm!-1814558751!1374248292256:/unitCallRouter servlet : ChkBadFetchExitPointPRE
19/07/2013 21:08:44:736 INFO - KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm!-1814558751!1374248292256:/unitCallRouter : [condition1] Condition [ctiXferRequested] String Equal Ignorecase [Y] next [null]
19/07/2013 21:08:44:736 DEBUG - KTYXRpdG27Rxl3bfyzGM5p2N8kxx2TpvTnV3pj8rqnTQLyJnB1Jm!-1814558751!1374248292256:/unitCallRouter : session id:AVP-MPP2-GUJ-2013200153705-27 | unitPrepaid:ChkBadFetchExitPointPRE | Bad fetch occured at start of Prepaid(Approot).Seeting product i

As you can see at 21:08:24 , vxml page in printed in log, and after 20 secondm error.badfetch event is captured. Post that a data node named "ChkBadFetchExitPointPRE" is called.

Please advise, what can be root cause of it.
I did the test call and I did not face this bad fetch. We have total call vloume of 7080 thousand calls and we can see 10% of calls are facing this issue at random nodes and random time.

Below some more details about setup:
1) Application server: Weblogic 10.3.6
2) Dialogue Designer 5.1.0.17
3) VPMS is at 1 location and application server (Weblogic ) is at another location. Both communcate with each other over WAN. We have verified there is no network latency issue.

Pls advise.

Satendra

Do you have the sessionslot log for the Voice Browser side? That will show why the VB generated a bad fetch error. From the app side, it isn't clear.

If not, set VB logging to finest on VPMS. When the error occurs, find the slot log that handled the call by using the sessionmgr log to track it down and that will show what the VB was doing when it generated a bad fetch.

Hi Neil,

In session Slot log I can see loads of errors:

@2013-07-11 11:56:53,650|PSESM00071|ERROR|SessMgr|16745|FileName=Session.cpp,LineNumber=209|CCXML or VXML timeout event occurred for session ID AVP-APP3-GUJ-2013192060408-1|AVP-APP3-GUJ####
@2013-07-11 12:52:28,248|PSESM00071|ERROR|SessMgr|16149|FileName=Session.cpp,LineNumber=209|CCXML or VXML timeout event occurred for session ID AVP-APP3-GUJ-2013192071208-1|AVP-APP3-GUJ####
@2013-07-11 16:35:32,954|PSESM00071|ERROR|SessMgr|16608|FileName=Session.cpp,LineNumber=209|CCXML or VXML timeout event occurred for session ID AVP-APP3-GUJ-2013192105118-1|AVP-APP3-GUJ####
@2013-07-12 01:17:22,870|PSESM00070|ERROR|SessMgr|19575|FileName=SessionMgr.cpp,LineNumber=1672|Application errors occurred for application Unit 198, Session ID AVP-APP3-GUJ-2013192194655-1, [vxml: PAVB_00186, vxml: PAVB_00213]|AVP-APP3-GUJ####
@2013-07-12 10:39:51,455|PSESM00071|ERROR|SessMgr|1542|FileName=Session.cpp,LineNumber=209|CCXML or VXML timeout event occurred for session ID AVP-APP3-GUJ-2013193045447-1|AVP-APP3-GUJ####

there are so many such errors.

Can it be issue for badfetch?

Satendra

Hi Neil,

I've collected the logs. Now tracking the particular call for bad fetch.

Will share the log. last logs were for old date.

Satendra

Hi Neil,

Below is the session slot log for 1 of badfetch issue, for which I had put trace log:

@2013-07-19 22:06:28,242||FINER|SessMgr|2070||Playing wavefile /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/209.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/GUJA_1.wav)|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5956:PromptPlayQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_REC_SET_PARAMS|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINEST|SessMgr|2070||******** Entering Dialog.cpp:3643:RecSetParams|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINER|SessMgr|2070||RecSetParams:|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINER|SessMgr|2070||inputmodes = dtmf voice|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.confidenceLevel = 0.500000|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.inputModes = 6|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.language = en-us|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.maxnbest = 1|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.sensitivity = 0.500000|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.speedVsAccuracy = 0.500000|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.timeout = 8000|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.timeoutTerminator = 0|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.dtmfMaxLen = 1|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.terminatorChar = #|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.timeoutInterdigit = 5000|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_REC_PARAMS_SET|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,249||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:3643:RecSetParams|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,249||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,249||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,249||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,249||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,252||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,252||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_PLAY|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5956:PromptPlayQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINE|SessMgr|2070||Play already active, doing nothing|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5956:PromptPlayQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_REC_RECOGNIZE|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Entering Dialog.cpp:4097:RequestRecognition|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Entering Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Leaving Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINER|SessMgr|2070||CDialog::RequestRecognition with mode 2 and HotWord 0|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Entering Dialog.cpp:4145:StartRecognition|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINER|SessMgr|2070||StartRecognition with mode 2, HotWord 0|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINER|SessMgr|2070||StartRecognition called with prompt play active, not starting no input timer...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Entering Call.cpp:1528:StartDtmfCollection|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||******** Leaving Call.cpp:1528:StartDtmfCollection|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:4145:StartRecognition|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:4097:RequestRecognition|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg : PlayDoneMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||ProcessPlayDone - Audio Prompt ID 3 is now done...|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||PromptPlay - Seq Node - Number of items 4|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||PromptPlay - Prompt Element Node - Prompt ID 4, item /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/211.sbc83891918.BAK,|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Entering Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||StartPromptElemPlay - Start play of Prompt type P_AUDIO, ID 4, Bargein: 1, TypeAhead 1, data [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/211.sbc83891918.BAK]|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINER|SessMgr|2070||Playing wavefile /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/211.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/HIND_2.wav)|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,033||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg : PlayDoneMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||ProcessPlayDone - Audio Prompt ID 4 is now done...|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||PromptPlay - Seq Node - Number of items 4|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||PromptPlay - Prompt Element Node - Prompt ID 5, item /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/213.sbc83891918.BAK,|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||StartPromptElemPlay - Start play of Prompt type P_AUDIO, ID 5, Bargein: 1, TypeAhead 1, data [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/213.sbc83891918.BAK]|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINER|SessMgr|2070||Playing wavefile /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/213.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/ENGL_3.wav)|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,683||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,683||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg : PlayDoneMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||ProcessPlayDone - Audio Prompt ID 5 is now done...|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||PromptPlay - Seq Node - Number of items 4|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||PromptPlay - Prompt Element Node - Prompt ID 6, item /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/215.sbc83891918.BAK,|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Leaving Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||StartPromptElemPlay - Start play of Prompt type P_AUDIO, ID 6, Bargein: 1, TypeAhead 1, data [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/215.sbc83891918.BAK]|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINER|SessMgr|2070||Playing wavefile /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/215.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/062.wav)|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg : PlayDoneMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||ProcessPlayDone - Audio Prompt ID 6 is now done...|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||PromptPlay - Seq Node - Number of items 4|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6119:SendPlayComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINER|SessMgr|2070||Prompt play is finised with recognition active, starting no input timer [8000]..., bargein = 0|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Call.cpp:1580:StartDtmfInitialTimeout|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,395||FINEST|SessMgr|2070||******** Leaving Call.cpp:1580:StartDtmfInitialTimeout|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,395||FINER|SessMgr|2070||Prompt play was completed...|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,395||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_PLAY_COMPLETE|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,395||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6031:PromptClearQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,395||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6031:PromptClearQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6119:SendPlayComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg : IncomingDtmfCompleteMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||******** Entering Call.cpp:2466:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||******** Entering Call.cpp:2372:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||******** Entering Dialog.cpp:3084:IncomingDtmfDigitsComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINER|SessMgr|2070||IncomingDtmfDigitsComplete: [] Reason = 6, Bargein = 0|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINER|SessMgr|2070||Speech Recognition not active, true DTMF event..|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_REC_ERROR|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:3084:IncomingDtmfDigitsComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||******** Leaving Call.cpp:2372:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||******** Leaving Call.cpp:2466:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_FETCHED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,430||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_QUEUE|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/33/76.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/010.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 1|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,432||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,432||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,432||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,432||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,432||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,432||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PAGE_LOADED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6542:PageLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINER|SessMgr|2070||VXML Page loaded: http://172.30.132.74:7003/unitPrepaid/unitSubflowLangSel-dataChkInvalidTries?___DDSESSIONID=LZ3pRprG3YcCbBhdfyklR2n2Q150p10lzwtXvYsZpF7GvXscGYTn%211468329135%211374251814829%3A%2FunitCallRouter, 116 [0, 0]|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||Call connected, save page URL: http://172.30.132.74:7003/unitPrepaid/unitSubflowLangSel-dataChkInvalidTries?___DDSESSIONID=LZ3pRprG3YcCbBhdfyklR2n2Q150p10lzwtXvYsZpF7GvXscGYTn%211468329135%211374251814829%3A%2FunitCallRouter|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6542:PageLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_FETCHED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_QUEUE|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/209.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/GUJA_1.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 2|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,569||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_FETCHED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_QUEUE|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/211.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/HIND_2.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 3|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,572||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,572||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,572||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_FETCHED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_QUEUE|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/213.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/ENGL_3.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 4|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_FETCHED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,586||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,587||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,587||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_QUEUE|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,587||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,587||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,587||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/215.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/062.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 5|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,670||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,670||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PAGE_LOADED|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6542:PageLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINER|SessMgr|2070||VXML Page loaded: http://172.30.132.74:7003/unitPrepaid/ChkBadFetchExitPointPRE?___DDSESSIONID=LZ3pRprG3YcCbBhdfyklR2n2Q150p10lzwtXvYsZpF7GvXscGYTn%211468329135%211374251814829%3A%2FunitCallRouter, 78 [0, 0]|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Call connected, save page URL: http://172.30.132.74:7003/unitPrepaid/ChkBadFetchExitPointPRE?___DDSESSIONID=LZ3pRprG3YcCbBhdfyklR2n2Q150p10lzwtXvYsZpF7GvXscGYTn%211468329135%211374251814829%3A%2FunitCallRouter|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6542:PageLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,679||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,680||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_FETCHED|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,680||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,680||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####


As per the log I can see, delay of 20 second, after playing 062.wav file:

@2013-07-19 22:06:47,588||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/215.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/062.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 5|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,670||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,670||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PAGE_LOADED|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6542:PageLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINER|SessMgr|2070||VXML Page loaded: http://172.30.132.74:7003/unitPrepaid/ChkBadFetchExitPointPRE?___DDSESSIONID=LZ3pRprG3YcCbBhdfyklR2n2Q150p10lzwtXvYsZpF7GvXscGYTn%211468329135%211374251814829%3A%2FunitCallRouter, 78 [0, 0]|AVP-MPP3-GUJ####


If I compare it with other prompts, I can see for rest of prompt log shows
1) Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED
2) "waiting for message"
3) got message of type VXMLMsg
4) got message of type VXMLMsg VXML_PROMPT_FETCHED

But the last prompt, it has only this entry:
1) Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED
2)Run - Waiting for message...

and after this 20 second of delay. It's din't print "VXML_PROMPT_FETCHED" for this promt.

At which end should we check to find the issue?
MPP voice browser end or the apache server which is hosting prompts?

Please advise.

Thanks:
Satendra

Hi Neil,

Below is the session slot log for 1 of badfetch issue, for which I had put trace log:

@2013-07-19 22:06:28,242||FINER|SessMgr|2070||Playing wavefile /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/209.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/GUJA_1.wav)|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5956:PromptPlayQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,242||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_REC_SET_PARAMS|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINEST|SessMgr|2070||******** Entering Dialog.cpp:3643:RecSetParams|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINER|SessMgr|2070||RecSetParams:|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,247||FINER|SessMgr|2070||inputmodes = dtmf voice|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.confidenceLevel = 0.500000|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.inputModes = 6|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.language = en-us|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.maxnbest = 1|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.sensitivity = 0.500000|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.speedVsAccuracy = 0.500000|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.timeout = 8000|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.timeoutTerminator = 0|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.dtmfMaxLen = 1|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.terminatorChar = #|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||vxi.rec.timeoutInterdigit = 5000|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,248||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_REC_PARAMS_SET|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,249||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:3643:RecSetParams|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,249||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,249||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,249||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,249||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,252||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,252||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_PLAY|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5956:PromptPlayQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINE|SessMgr|2070||Play already active, doing nothing|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5956:PromptPlayQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,253||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_REC_RECOGNIZE|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Entering Dialog.cpp:4097:RequestRecognition|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Entering Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Leaving Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINER|SessMgr|2070||CDialog::RequestRecognition with mode 2 and HotWord 0|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Entering Dialog.cpp:4145:StartRecognition|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINER|SessMgr|2070||StartRecognition with mode 2, HotWord 0|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINER|SessMgr|2070||StartRecognition called with prompt play active, not starting no input timer...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,254||FINEST|SessMgr|2070||******** Entering Call.cpp:1528:StartDtmfCollection|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||******** Leaving Call.cpp:1528:StartDtmfCollection|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:4145:StartRecognition|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:4097:RequestRecognition|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:28,255||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg : PlayDoneMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||ProcessPlayDone - Audio Prompt ID 3 is now done...|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||PromptPlay - Seq Node - Number of items 4|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||PromptPlay - Prompt Element Node - Prompt ID 4, item /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/211.sbc83891918.BAK,|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,885||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Entering Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||StartPromptElemPlay - Start play of Prompt type P_AUDIO, ID 4, Bargein: 1, TypeAhead 1, data [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/211.sbc83891918.BAK]|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINER|SessMgr|2070||Playing wavefile /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/211.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/HIND_2.wav)|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:30,886||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,033||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg : PlayDoneMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||ProcessPlayDone - Audio Prompt ID 4 is now done...|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||PromptPlay - Seq Node - Number of items 4|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||PromptPlay - Prompt Element Node - Prompt ID 5, item /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/213.sbc83891918.BAK,|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||StartPromptElemPlay - Start play of Prompt type P_AUDIO, ID 5, Bargein: 1, TypeAhead 1, data [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/213.sbc83891918.BAK]|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINER|SessMgr|2070||Playing wavefile /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/213.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/ENGL_3.wav)|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:33,034||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,683||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,683||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg : PlayDoneMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||ProcessPlayDone - Audio Prompt ID 5 is now done...|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||PromptPlay - Seq Node - Number of items 4|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||PromptPlay - Prompt Element Node - Prompt ID 6, item /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/215.sbc83891918.BAK,|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Leaving Call.cpp:2505:CheckForMediaActive|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||StartPromptElemPlay - Start play of Prompt type P_AUDIO, ID 6, Bargein: 1, TypeAhead 1, data [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/215.sbc83891918.BAK]|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,684||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINER|SessMgr|2070||Playing wavefile /opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/215.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/062.wav)|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2419:PlayFile|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5641:StartPromptElemPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:35,685||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg : PlayDoneMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||ProcessPlayDone - Audio Prompt ID 6 is now done...|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||PromptPlay - Seq Node - Number of items 4|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5412:PromptPlay|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6119:SendPlayComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINER|SessMgr|2070||Prompt play is finised with recognition active, starting no input timer [8000]..., bargein = 0|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,394||FINEST|SessMgr|2070||******** Entering Call.cpp:1580:StartDtmfInitialTimeout|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,395||FINEST|SessMgr|2070||******** Leaving Call.cpp:1580:StartDtmfInitialTimeout|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,395||FINER|SessMgr|2070||Prompt play was completed...|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,395||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_PLAY_COMPLETE|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,395||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6031:PromptClearQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,395||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6031:PromptClearQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6119:SendPlayComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6199:ProcessPromptNodeComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:2467:ProcessPlayDone|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:39,396||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||Run - got message of type TelephonyEndPointMsg : IncomingDtmfCompleteMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||******** Entering Call.cpp:2466:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||******** Entering Call.cpp:2372:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINEST|SessMgr|2070||******** Entering Dialog.cpp:3084:IncomingDtmfDigitsComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINER|SessMgr|2070||IncomingDtmfDigitsComplete: [] Reason = 6, Bargein = 0|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,398||FINER|SessMgr|2070||Speech Recognition not active, true DTMF event..|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_REC_ERROR|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:3084:IncomingDtmfDigitsComplete|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7406:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||******** Leaving Call.cpp:2372:ProcessEndPointMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||******** Leaving Call.cpp:2466:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,420||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_FETCHED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,429||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,430||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_QUEUE|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/33/76.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/010.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,431||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 1|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,432||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,432||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,432||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,432||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,432||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,432||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PAGE_LOADED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6542:PageLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINER|SessMgr|2070||VXML Page loaded: http://172.30.132.74:7003/unitPrepaid/unitSubflowLangSel-dataChkInvalidTries?___DDSESSIONID=LZ3pRprG3YcCbBhdfyklR2n2Q150p10lzwtXvYsZpF7GvXscGYTn%211468329135%211374251814829%3A%2FunitCallRouter, 116 [0, 0]|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||Call connected, save page URL: http://172.30.132.74:7003/unitPrepaid/unitSubflowLangSel-dataChkInvalidTries?___DDSESSIONID=LZ3pRprG3YcCbBhdfyklR2n2Q150p10lzwtXvYsZpF7GvXscGYTn%211468329135%211374251814829%3A%2FunitCallRouter|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6542:PageLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,551||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_FETCHED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,560||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_QUEUE|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/209.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/GUJA_1.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 2|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,563||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,569||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_FETCHED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,570||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_QUEUE|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/211.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/HIND_2.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 3|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,571||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,572||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,572||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,572||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_FETCHED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,578||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_QUEUE|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/213.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/ENGL_3.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 4|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,580||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_FETCHED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,585||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,586||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,587||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,587||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_QUEUE|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,587||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,587||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,587||FINEST|SessMgr|2070||******** Entering Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/215.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/062.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 5|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,670||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,670||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PAGE_LOADED|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6542:PageLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINER|SessMgr|2070||VXML Page loaded: http://172.30.132.74:7003/unitPrepaid/ChkBadFetchExitPointPRE?___DDSESSIONID=LZ3pRprG3YcCbBhdfyklR2n2Q150p10lzwtXvYsZpF7GvXscGYTn%211468329135%211374251814829%3A%2FunitCallRouter, 78 [0, 0]|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Call connected, save page URL: http://172.30.132.74:7003/unitPrepaid/ChkBadFetchExitPointPRE?___DDSESSIONID=LZ3pRprG3YcCbBhdfyklR2n2Q150p10lzwtXvYsZpF7GvXscGYTn%211468329135%211374251814829%3A%2FunitCallRouter|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6542:PageLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6496:PageItemLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,679||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,680||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PROMPT_FETCHED|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,680||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,680||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####


As per the log I can see, delay of 20 second, after playing 062.wav file:

@2013-07-19 22:06:47,588||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/215.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/062.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 5|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,670||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,670||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PAGE_LOADED|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6542:PageLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINER|SessMgr|2070||VXML Page loaded: http://172.30.132.74:7003/unitPrepaid/ChkBadFetchExitPointPRE?___DDSESSIONID=LZ3pRprG3YcCbBhdfyklR2n2Q150p10lzwtXvYsZpF7GvXscGYTn%211468329135%211374251814829%3A%2FunitCallRouter, 78 [0, 0]|AVP-MPP3-GUJ####


If I compare it with other prompts, I can see for rest of prompt log shows
1) Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED
2) "waiting for message"
3) got message of type VXMLMsg
4) got message of type VXMLMsg VXML_PROMPT_FETCHED

But the last prompt, it has only this entry:
1) Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED
2)Run - Waiting for message...

and after this 20 second of delay. It's din't print "VXML_PROMPT_FETCHED" for this promt.

At which end should we check to find the issue?
MPP voice browser end or the apache server which is hosting prompts?

Please advise.

Thanks:
Satendra

Hi Neil,

I re verified the sequence of Prompt announcement for success and bad fetch scenarios for same node, and below is the analysis:

Prompts sequences are: GUJA_1.wav, HIND_2.wav, ENGL_3.wav and last 062.wav

success scenario, pasting logs after last wav fie(ie. 062.wav)

@2013-07-19 22:03:46,001||FINER|SessMgr|6063||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/179.sbc83891880.BAK (http://172.24.141.24/Unitech/Audio/engl/062.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,001||FINER|SessMgr|6063||PromptQueue - Adding to a SEQ node, number of items = 4|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,001||FINER|SessMgr|6063||Sending VXML message to session 83891880, Message type = VXML_PROMPT_QUEUED|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,001||FINEST|SessMgr|6063||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,001||FINEST|SessMgr|6063||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,001||FINEST|SessMgr|6063||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,001||FINEST|SessMgr|6063||Checking for Call disconnects...|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,001||FINEST|SessMgr|6063||Run - Waiting for message...|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,120||FINEST|SessMgr|6063||Run - got message of type VXMLMsg|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,121||FINEST|SessMgr|6063||Run - got message of type VXMLMsg : VXML_PAGE_LOADED|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,121||FINEST|SessMgr|6063||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,121||FINEST|SessMgr|6063||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,121||FINEST|SessMgr|6063||******** Entering Dialog.cpp:6542:PageLoaded|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,121||FINER|SessMgr|6063||VXML Page loaded: http://172.30.132.74:7003/unitPrepaid/subPlayVXMLAudio-vxmlReturn?___DDSESSIONID=yKwmRpqGvLNJgHfK4qbl4cjpR7t223GggbZT1CC5v9s4nm1CmzWc%211468329135%211374251654767%3A%2FunitCallRouter, 114 [0, 0]|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,121||FINEST|SessMgr|6063||Call connected, save page URL: http://172.30.132.74:7003/unitPrepaid/subPlayVXMLAudio-vxmlReturn?___DDSESSIONID=yKwmRpqGvLNJgHfK4qbl4cjpR7t223GggbZT1CC5v9s4nm1CmzWc%211468329135%211374251654767%3A%2FunitCallRouter|AVP-MPP1-GUJ####
@2013-07-19 22:03:46,121||FINEST|SessMgr|6063||******** Leaving Dialog.cpp:6542:PageLoaded|AVP-MPP1-GUJ####

Here we can see after last wav fileis queued(i.e after GUJA_1.wav, HIND_2.wav and ENGL.wav) for last wav file PAGE UPLOAD happened in fraction of milliseconds.

But in case of Badfetch scenario:

22:06:47,588||FINER|SessMgr|2070||Queueing Prompt mode [PromptSeqNode]: Type P_AUDIO, [/opt/Avaya/VoicePortal/MPP/AVB/cache5/swi_OSBinet/32/215.sbc83891918.BAK (http://172.24.141.24/Unitech/Audio/engl/062.wav)], language = none, gender = female, bargein = 1, Outputmodes = audio video|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINER|SessMgr|2070||PromptQueue - Adding to a SEQ node, number of items = 5|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINER|SessMgr|2070||Sending VXML message to session 83891918, Message type = VXML_PROMPT_QUEUED|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:5282:PromptQueue|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||******** Leaving Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:06:47,588||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,670||FINEST|SessMgr|2070||Checking for Call disconnects...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,670||FINEST|SessMgr|2070||Run - Waiting for message...|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Run - got message of type VXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Run - got message of type VXMLMsg : VXML_PAGE_LOADED|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:7638:ProcessMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6778:ProcessVXMLMsg|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||******** Entering Dialog.cpp:6542:PageLoaded|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINER|SessMgr|2070||VXML Page loaded: http://172.30.132.74:7003/unitPrepaid/ChkBadFetchExitPointPRE?___DDSESSIONID=LZ3pRprG3YcCbBhdfyklR2n2Q150p10lzwtXvYsZpF7GvXscGYTn%211468329135%211374251814829%3A%2FunitCallRouter, 78 [0, 0]|AVP-MPP3-GUJ####
@2013-07-19 22:07:07,671||FINEST|SessMgr|2070||Call connected, save page URL: http://172.30.132.74:7003/unitPrepaid/ChkBadFetchExitPointPRE?___DDSESSIONID=LZ3pRprG3YcCbBhdfyklR2n2Q150p10lzwtXvYsZpF7GvXscGYTn%211468329135%211374251814829%3A%2FunitCallRouter|AVP-MPP3-GUJ####

We can seen after last wav file is queued, page upload message came after 20 second and so bad fetch event,

Can you please help,which end we need to look for this?
MPP end or the server hosting wav files.

We have apache http server which is keeping wav files and both MPP and this server is at same location communication over LAN.
Please help we are facing production issue.

Thanks:
Satendra

From the errors you show, they look like they come from MPP3. Is it consistent that MPP3 has the problematic calls?

You should bring this log to Avaya Voice Portal customer support. The issue is on the platform and they will be able to better troubleshoot it.

Hi Neil,

We have 3 MPPs and we are facing this issue in almost all Mpps.

Issue in MPP3 is more frequent than others.

Thanks:
Satendra

Please check with VP support on this.