Gents,
I have an issue with MVA. MVA collects PIN and I press 1 to dial but it does
not proceed with any call instead the well known prompt sounds: "The call
cannot be completed..." Even if the called number is local and placed in the
<None> partition.
This prompt suggests CSS issue however as Vik advised before I created a
totally new CSS just for RDP but it does not solve the problem.
Service Parameters: Complete Match and RDP+Line CSS.
I have read near all the thread regarding MVA here, but the issue remains. I
attached the vxml debug.
Any suggestion?
HQ-RTR#sh run
Building configuration...
Current configuration : 5107 bytes
!
! Last configuration change at 18:15:20 UTC Tue May 18 2010
! NVRAM config last updated at 18:15:21 UTC Tue May 18 2010
!
version 12.4
service timestamps debug datetime msec
service timestamps log datetime msec
no service password-encryption
no service password-recovery
!
hostname HQ-RTR
!
boot-start-marker
boot system flash c2800nm-ipvoice_ivs-mz.124-20.T2.bin
warm-reboot
boot-end-marker
!
logging message-counter syslog
logging buffered 51200 warnings
!
no aaa new-model
memory-size iomem 20
network-clock-participate wic 0
network-clock-participate wic 1
network-clock-select 1 E1 0/1/0
!
no ip source-route
!
!
ip cef
!
!
no ip domain lookup
ip multicast-routing
multilink bundle-name authenticated
!
isdn switch-type primary-ni
!
!
!
voice service voip
allow-connections h323 to sip
!
!
!
voice class codec 1
codec preference 1 g711ulaw
codec preference 2 g729r8
!
!
!
/dial-p
filtering...
dial-peer voice 15 voip
voice-class codec 1
incoming called-number .
!
dial-peer voice 1 pots
incoming called-number .
direct-inward-dial
!
dial-peer voice 911 pots
destination-pattern 911
clid strip name
no digit-strip
port 0/1/0:15
!
dial-peer voice 7 pots
destination-pattern 9[2-9]......
port 0/1/0:15
forward-digits 7
!
dial-peer voice 11 pots
destination-pattern 91[2-9]..[2-9]......
port 0/1/0:15
forward-digits 11
!
dial-peer voice 5000 voip
destination-pattern 5...$
voice-class codec 1
voice-class h323 1
session target ipv4:10.10.210.11
dtmf-relay h245-alphanumeric
no vad
!
dial-peer voice 5001 voip
preference 1
destination-pattern 5...$
voice-class codec 1
voice-class h323 1
session target ipv4:10.10.210.10
dtmf-relay h245-alphanumeric
no vad
!
dial-peer voice 5999 pots
service cmm
incoming called-number 5999
!
!
!
gatekeeper
zone local US ipexpert.com
zone local Spain ipexpert.com
zone remote PSTN-WAN ipexpert.com 10.10.100.2 1719
zone prefix Spain 34*
zone prefix PSTN-WAN 91*
HQ-RTR#un all
All possible debugging has been turned off
HQ-RTR#deb voip appl vxml all
vxml all debugging is on
HQ-RTR#
May 18 18:57:48.209: //44//VXML:/Open_SetupIndication:
May 18 18:57:48.213: //44//AFW_:/vapp_vxmldialog: Trusted=0, DNIS Map URI=,
Code = {
}
May 18 18:57:48.213: //44//AFW_:/vapp_vxmldialog: After DNIS Map
URI=http://10.10.210.10/ccmivr/pages/IVRMainpage.vxml, Code = {
<?xml version="1.0" encoding="iso-8859-1"?>
<vxml version="2.0">
<form id="
}
May 18 18:57:48.213: //-1//AFW_:/AFW_VxmlModule_New:
May 18 18:57:48.213: //-1//VXM
HQ-RTR#L:/vxml_tree_lock:
vxmlp=47E35714 usage_cnt=0
May 18 18:57:48.217: //0/15E3016C800D/VXML:/vxml_parse:
May 18 18:57:48.217: vxml_parse: XML_Parse success err=0
May 18 18:57:48.217: //0/15E3016C800D/VXML:/vxml_session_delete:
May 18 18:57:48.217: vxml_session_delete:mem_mgr_mempool_free: mempool=NULL
May 18 18:57:48.217: vxml_session_delete:mem_mgr_mempool_free: mempool=NULL
May 18 18:57:48.217: //-1//VXML:/vxml_crc_generate_element_tree: 28 crc
generated
May 18 18:57:48.217: //-1//VXML:/vxml_create:
enter url=http://10.10.210.10/ccmivr/pages/IVRMainpage.vxml
tree_handle=47E35714
return_handle_add=48547838
May 18 18:57:48.245: //44//AFW_:/vapp_get_type_detail:
May 18 18:57:48.245: //44/15E3016C800D/VXML:/vxml_offramp_mailhdrs_get:
May 18 18:57:48.245: //44//AFW_:/vapp_get_incoming_gtd_list:
May 18 18:57:48.249: //44/15E3016C800D/VXML:/vxml_jse_add_gtd_obj_to_list:
Sig-event name = setup_indication, gtd-len = 176, gtd-buf =
IAM,
PRN,isdn*,,NI***,
USI,rate,c,s,c,1
USI,lay1,alaw
TMR,00
HQ-RTR#CPN,04,,1,2123945999
CGN,02,,1,y,1,2123942123
CPC,09
FCI,,,,,,,y,
GCI,15e3016c61e611df800d001e1335ff88
May 18 18:57:48.249: //44/15E3016C800D/VXML:/vxml_jse_add_gtd_obj_to_list:
gtd_obj for sig-event [setup_indication] added to session/shadow
var array [0x4850DE2C]
May 18 18:57:48.249: //44/15E3016C800D/VXML:/vxml_create_gtd_sess_vars:
Created object chain for com.cisco.signal.gtdlist
May 18 18:57:48.249: //-1//VXML:/vxml_create: Exit
May 18 18:57:48.249: //44/15E3016C800D/VXML:/vxml_start:
vxmlhandle=47E34858 vapphandle=47E31A24 status=0 async_status=0
May 18 18:57:48.249: //44/15E3016C800D/VXML:/vxml_vxml_proc:
<vxml>
URI(abs):http://10.10.210.10/ccmivr/pages/IVRMainpage.vxml
scheme=http
host=10.10.210.10
path=/ccmivr/pages/IVRMainpage.vxml
base=
URI(abs):http://10.10.210.10/ccmivr/pages/IVRMainpage.vxml
scheme=http
host=10.10.210.10
path=/ccmivr/pages/IVRMainpage.vxml lang=none version=2.0
May 18 18:57:48.249: //44/15E3016C800D/VXML:/vxml_form_proc:
May 18 18:57:48.249: <form>: id=main scope=dialog
May 18 18:57:48.249: //44/15E3016C800D/VXML:/vxml_form_init:
current scope: dialog
vxml_counter_reset:
May 18 18:57:48.249: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var _in31)
May 18 18:57:48.249: //44/15E3016C800D/VXML:/vxml_jse_global_switch:
switch to scope(dialog)
May 18 18:57:48.253: //44/15E3016C800D/VXML:/vxml_formitem_select:
Status=VXML_STATUS_OK,
May 18 18:57:48.253: //44/15E3016C800D/VXML:/vxml_formitem_select:
AsyncStatus=VXML_STATUS_OK
May 18 18:57:48.253: //44/15E3016C800D/VXML:/vxml_block_proc:
May 18 18:57:48.253: <block>:
May 18 18:57:48.253: //44/15E3016C800D/VXML:/vxml_item_attrs_proc:
name=_in31
May 18 18:57:48.253: //-1//VXML:/vxml_prompt_proc: Enter
May 18 18:57:48.253: //44/15E3016C800D/VXML:/vxml_prompt_proc:
<prompt>: typeaheadflush=0 alternative=0
May 18 18:57:48.253: //-1//VXML:/vxml_process_prompt: Enter
May 18 18:57:48.253: //-1//VXML:/vxml_audio_proc: Enter
May 18 18:57:48.253: //44/15E3016C800D/VXML:/vx
HQ-RTR#ml_audio_proc:
<audio>:
URI(abs):http://10.10.210.10:8080/ccmivr/IVRGetAudioFile.do?srcdir=en_US&file=1.au
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRGetAudioFile.do
query=srcdir=en_US&file=1.au caching=fast fetchhint=invalid fetchtimeout=0
maxage=-1 maxstale=-1
May 18 18:57:48.253: //-1//VXML:/vxml_audio_proc: Exit
May 18 18:57:48.253: //-1//VXML:/vxml_finish_generate_prompt_list: Enter
May 18 18:57:48.253: //-1//VXML:/vxml_finish_generate_prompt_list: Exit
May 18 18:57:48.253: //-1//VXML:/vxml_process_prompt: Exit
May 18 18:57:48.253: //44/15E3016C800D/VXML:/vxml_vapp_media_play:
bargein=1 timeout=0 typeaheadflush=0 vcr=0 rate=0 alternative=0 hotword=0
maxtime=0
May 18 18:57:48.253: //44/15E3016C800D/VXML:/vxml_vapp_media_play:
str=http://10.10.210.10:8080/ccmivr/IVRGetAudioFile.do?srcdir=en_US&file=1.au
cachable=1 timeout0 maxage=-1 maxstale=-1 codec=-1
May 18 18:57:48.253: //44//AFW_:/vapp_media_play:
May 18 18:57:48.253: //44//AFW_:/vapp_media_play:
prompt=http://10.10.210.10:8080/ccmivr/IVRGetAudioFile.do?srcdir=en_US&file=1.au:
May 18 18:57:48.257: //-1//VXML:/vxml_vapp_media_play: Exit
May 18 18:57:48.257: //-1//VXML:/vxml_prompt_proc: Exit
<var>: namep=remotedest
May 18 18:57:48.257: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var remotedest)
May 18 18:57:48.257: //44/15E3016C800D/VXML:/vxml_jse_global_switch:
switch to scope(anonymous)
May 18 18:57:48.257: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=remotedest expr=session.telephone.ani
May 18 18:57:48.257: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(remotedest=session.telephone.ani)
<var>: namep=srcdir
May 18 18:57:48.257: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var srcdir)
May 18 18:57:48.261: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=srcdir expr='en_US'
May 18 18:57:48.261: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(srcdir='en_US')
May 18 18:57:48.261: //44/15E3016C800D/VXML:/vxml_if_proc:
<if>: cond=remotedest !='blocked'
May 18 18:57:48.261: //-1//VXML:/vxml_submit_proc: Enter
May 18 18:57:48.261: //44/15E3016C800D/VXML:/vxml_submit_proc:
<submit>: caching=fast fetchhint=invalid fetchtimeout=0 maxage=-1
maxstale=-1
URI(abs):http://10.10.210.10:8080/ccmivr/IVRCalleridLookup.do
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRCalleridLookup.do
May 18 18:57:48.261: //44/15E3016C800D/VXML:/vxml_sub_attrs_proc:
method=get
enctype=application/x-www-form-urlencoded
May 18 18:57:48.261: //44/15E3016C800D/VXML:/vxml_nmtokens_proc:
name=remotedest
name=srcdir
May 18 18:57:48.261: //-1//VXML:/vxml_sub_attrs_proc: Enter
May 18 18:57:48.261: //-1//VXML:/vxml_sub_attrs_proc: Exit
May 18 18:57:48.261: //44/15E3016C800D/VXML:/vxml_vapp_bgload_from_proc:
urlp=http://10.10.210.10:8080/ccmivr/IVRCalleridLookup.do?remotedest=2123942123&srcdir=en_US
fetchaudio=NULL delay=0 minimum=0
May 18 18:57:48.261: //44/15E3016C800D/VXML:/vxml_vapp_bgload:
url
http://10.10.210.10:8080/ccmivr/IVRCalleridLookup.do?remotedest=2123942123&srcdir=en_US
cachable 1 fetchtimeout 0 maxage=-1 maxstale=-1
May 18 18:57:48.261: //44//AFW_:/vapp_bgload:
url=http://10.10.210.10:8080/ccmivr/IVRCalleridLookup.do?remotedest=2123942123&srcdir=en_US
May 18 18:57:48.261: //44//AFW_:/vxml_update_cleanup_timer: cleaning timer
running 0 fetchtimeout 0
May 18 18:57:48.261: //-1//VXML:/vxml_vapp_bgload: Exit
May 18 18:57:48.261: //-1//VXML:/vxml_vapp_bgload_from_proc: normal_async_load,
e...@8233
May 18 18:57:48.265: //-1//VXML:/vxml_submit_proc: Exit
May 18 18:57:48.265: //-1//VXML:/vxml_elem_proc:
(400000000) Status not OK, e...@9897
May 18 18:57:48.265: //-1//VXML:/vxml_if_proc:
(400000000) Status not OK, e...@5724
May 18 18:57:48.265: //-1//VXML:/vxml_elem_proc:
(400000000) Status not OK, e...@9897
May 18 18:57:48.265: //44/15E3016C800D/VXML:/vxml_leave_scope:
scope=anonymous
May 18 18:57:48.265: //-1//VXML:/vxml_block_proc: Exit (400000000)
May 18 18:57:48.265: //-1//VXML:/vxml_elem_proc:
(400000000) Status not OK, e...@9897
May 18 18:57:48.265: //-1//VXML:/vxml_fo
HQ-RTR#rmitem_select:
(400000000) Status not OK, e...@5383
May 18 18:57:48.265: //-1//VXML:/vxml_form_proc:
(400000000) Status not OK, e...@5535
May 18 18:57:48.265: //-1//VXML:/vxml_elem_proc:
(400000000) Status not OK, e...@9897
May 18 18:57:48.265: //-1//VXML:/vxml_vxml_proc:
(400000000) Status not OK, e...@10094
May 18 18:57:48.265: //44/15E3016C800D/VXML:/vxml_load_immediate_done:
sidp->status=400000000
May 18 18:57:48.265: //44//AFW_:/vapp_checksessionstate:
May 18 18:57:48.265: //44//AFW_:/vapp_checkif
HQ-RTR#done: Object: 1, Leg: 1
May 18 18:57:48.265: CNG tone sent
May 18 18:57:48.281: //44//AFW_:/vapp_driver: evtID: 38 vapp record state: 0
May 18 18:57:48.281: //44//AFW_:/vapp_checksessionstate:
May 18 18:57:48.281: //44//AFW_:/vapp_checkifdone: Object: 1, Leg: 1
May 18 18:57:48.285: %ISDN-6-CONNECT: Interface Serial0/1/0:0 is now connected
to 2123942123 N/A
May 18 18:57:48.285: %ISDN-6-CONNECT: Interface Serial0/1/0:0 is now connected
to 2123942123 N/A
May 18 18:57:48.285: %ISDN-6-CONNECT: Interface Serial0/1/0:0 is now con
HQ-RTR#nected to 2123942123 N/A
May 18 18:57:48.341: //44//HIFS:/hifs_http_cb: hifs http read succeeded.
size=1198,
url=http://10.10.210.10:8080/ccmivr/IVRCalleridLookup.do?remotedest=2123942123&srcdir=en_US
May 18 18:57:48.341: //44//AFW_:/vapp_bgload_done: status=No Error
May 18 18:57:48.341: //44//HIFS:/hifs_http_cb: hifs ifs file read succeeded.
size=1198,
url=http://10.10.210.10:8080/ccmivr/IVRCalleridLookup.do?remotedest=2123942123&srcdir=en_US
May 18 18:57:48.341: //44//HIFS:/hifs_free_idata: hifs_free_idata: 0x47C56CDC
May 18 18:57:48.341: //44//HIFS:/hifs_hold_idata: hifs_hold_idata: 0x47C56CDC
May 18 18:57:48.345: //44//AFW_:/vapp_driver: evtID: 220 vapp record state: 0
May 18 18:57:48.345: //44//AFW_:/vapp_bgload_done_event:
May 18 18:57:48.345: //44//AFW_:/vapp_bgload_done_event: length=1198, page
loaded=
<vxml version="2.0">
<form id="Pin">
<grammar type="application/grammar+regex">.</grammar>
<field name="pin" type="digits?minlength=1;maxlength=20">
<prompt>
<audio s
May 18 18:57:48.345: /
HQ-RTR#/44/15E3016C800D/VXML:/vxml_is_doc:
vxml_is_doc
May 18 18:57:48.345: //-1//VXML:/vxml_tree_lock:
vxmlp=48479894 usage_cnt=0
May 18 18:57:48.349: //0/15E3016C800D/VXML:/vxml_parse:
May 18 18:57:48.349: vxml_parse: XML_Parse success err=0
May 18 18:57:48.349: //0/15E3016C800D/VXML:/vxml_session_delete:
May 18 18:57:48.349: vxml_session_delete:mem_mgr_mempool_free: mempool=NULL
May 18 18:57:48.349: vxml_session_delete:mem_mgr_mempool_free: mempool=NULL
May 18 18:57:48.349: //-1//VXML:/vxml_crc_generate_element_tree: 23 crc
generated
May 18 18:57:48.349: //44/15E3016C800D/VXML:/vxml_bgload_post_done:
vxmlhandle=47E34858 status=0 async_status=400000000
May 18 18:57:48.349: //44/15E3016C800D/VXML:/vxml_bgload_post_done:
Loading file with url
(http://10.10.210.10:8080/ccmivr/IVRCalleridLookup.do?remotedest=2123942123&srcdir=en_US)
May 18 18:57:48.349: //-1//VXML:/vxml_is_cisco_data: Enter
May 18 18:57:48.349: //44/15E3016C800D/VXML:/vxml_leave_scope:
scope=application
May 18 18:57:48.349: //-1//VXML:/vxml_crc_verify_element_tree: 28 crc verified
May 18 18:57:48.353: //44/15E3016C800D/VXML:/vxml_tree_delete:
vxmlp=47E35714, usage_cnt=1
url=http://10.10.210.10/ccmivr/pages/IVRMainpage.vxml
May 18 18:57:48.353: vxml_tree_delete:mem_mgr_mempool_free:
mem_refcnt(475D3E80)=0 - mempool cleanup
May 18 18:57:48.353: //44/15E3016C800D/VXML:/vxml_stop_fetchaudio:
May 18 18:57:48.353: //44/15E3016C800D/VXML:/vxml_start:
vxmlhandle=47E34858 vapphandle=47E31A24 status=0 async_status=80000
May 18 18:57:48.353: //44/15E30
HQ-RTR#16C800D/VXML:/vxml_vxml_proc:
<vxml>
URI(abs):http://10.10.210.10:8080/ccmivr/IVRCalleridLookup.do?remotedest=2123942123&srcdir=en_US
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRCalleridLookup.do
query=remotedest=2123942123&srcdir=en_US
base=
URI(abs):http://10.10.210.10:8080/ccmivr/IVRCalleridLookup.do?remotedest=2123942123&srcdir=en_US
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRCalleridLookup.do
query=remotedest=2123942123&srcdir=en_US lang=none version=2.0
May 18 18:57:48.353: //44/15E3016C800D/VXML:/vxml_form_proc:
May 18 18:57:48.353: <form>: id=Pin scope=dialog
May 18 18:57:48.353: //44/15E3016C800D/VXML:/vxml_form_init:
current scope: dialog
vxml_counter_reset:
May 18 18:57:48.353: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var pin)
May 18 18:57:48.353: //44/15E3016C800D/VXML:/vxml_jse_global_switch:
switch to scope(dialog)
May 18 18:57:48.357: //44/15E3016C800D/VXML:/vxml_formitem_select:
Status=VXML_STATUS_OK,
May 18 18:57:48.357: //44/15E3016C800D/VXML:/vxml_formitem_select:
AsyncStatus=VXML_STATUS_OK
May 18 18:57:48.357: //-1//VXML:/vxml_field_proc: Enter
May 18 18:57:48.357: //44/15E3016C800D/VXML:/vxml_field_proc:
May 18 18:57:48.357: <field>: type=digits
May 18 18:57:48.357: //44/15E3016C800D/VXML:/vxml_item_attrs_proc:
name=pin modal=aai prompt_counter=1
May 18 18:57:48.357: //-1//VXML:/vxml_play_prompts: Enter
May 18 18:57:48.357: //-1//VXML:/vxml_prompt_proc: Enter
May 18 18:57:48.357: //44/15E3016C800D/VXML:/vxml_prompt_proc:
<prompt>: typeaheadflush=0 alternative=0
May 18 18:57:48.357: //-1//VXML:/vxml_process_prompt: Enter
May 18 18:57:48.357: //-1//VXML:/vxml_audio_proc: Enter
May 18 18:57:48.357: //44/15E3016C800D/VXML:/vxml_audio_proc:
<audio>:
URI(abs):IVRGetAudioFile.do?srcdir=en_US&file=5.au
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRGetAudioFile.do
query=srcdir=en_US&file=5.au caching=fast fetchhint=invalid fetchtimeout=0
maxage=-1 maxstale=-1
May 18 1
HQ-RTR#8:57:48.357: //-1//VXML:/vxml_audio_proc: Exit
May 18 18:57:48.357: //-1//VXML:/vxml_finish_generate_prompt_list: Enter
May 18 18:57:48.357: //-1//VXML:/vxml_finish_generate_prompt_list: Exit
May 18 18:57:48.357: //-1//VXML:/vxml_process_prompt: Exit
May 18 18:57:48.357: //-1//VXML:/vxml_prompt_proc: Exit
May 18 18:57:48.357: //-1//VXML:/vxml_play_prompts: Exit
May 18 18:57:48.357: //-1//VXML:/vxml_generic_digit_collect: Enter
May 18 18:57:48.357: //44/15E3016C800D/VXML:/vxml_vapp_digit_collect:
termchar # minlength 1 maxlength 20 timeout 15000 interdigittimeout 10000
numPatterns=0hotword 0 abortKey
May 18 18:57:48.357: //44//AFW_:/vapp_digit_collect:
May 18 18:57:48.357: //44//AFW_:/vapp_digit_collect: numPatterns 0, minlength
1, maxlength 20, timeout 15000, interDigitTimeout 10000 hotword 0
May 18 18:57:48.357: //-1//VXML:/vxml_vapp_digit_collect: Exit
May 18 18:57:48.357: //-1//VXML:/vxml_generic_digit_collect: Exit
May 18 18:57:48.357: //-1//VXML:/vxml_field_proc: Exit
May 18 18:57:48.361: //-1//VXML:/vxml_elem_proc:
(300000000) Status not OK, e...@9897
May 18 18:57:48.361: //-1//VXML:/vxml_formitem_select:
(300000000) Status not OK, e...@5383
May 18 18:57:48.361: //-1//VXML:/vxml_form_proc:
(300000000) Status not OK, e...@5535
May 18 18:57:48.361: //-1//VXML:/vxml_elem_proc:
(300000000) Status not OK, e...@9897
May 18 18:57:48.361: //-1//VXML:/vxml_vxml_proc:
(300000000) Status not OK, e...@10094
May 18 18:57:48.361: //44/15E3016C800D/VXML:/vxml_load_immediate_done:
sidp->status=300000000
May 18 18:57:48.361: //-1//VXML:/vxml_bgload_post_done: Async load, e...@6757
May 18 18:57:48.361: //-1//VXML:/vxml_bgload_post_done: return
May 18 18:57:48.361: //44//AFW_:/vapp_checksessionstate:
May 18 18:57:48.361: //44//AFW_:/vapp_checkifdone: Object: 2, Leg: 1
May 18 18:57:48.365: CNG tone sent
May 18 18:57:50.841: //44//AFW_:/vapp_driver: evtID: 156 vapp record state: 0
May 18 18:57:50.841: //44//AFW_:/vapp_play_done: evID=156 reason=11,
protocol=2, status_code=0, dur=3219, rate=0
May 18 18:57:50.841: //44/15E3016C800D/VXML:/vxml_media_done:
status 18 async_status 300000000 duration=3219 rate=0
May 18 18:57:50.841: //44/15E3016C800D/VXML:/vxml_save_lastprompt_info:
May 18 18:57:50.841: //44//AFW_:/vapp_bargein_digit_collect_done:
May 18 18:57:50.841: //44/15E3016C800D/VXML:/vxml_save_lastprompt_info:
May 18 18:57:50.841: //44//AFW_:/vapp_notify_play_done:
May 18 18:57:50.841: //44//AFW_:/vapp_notify_play_done:
May 18 18:57:50.841: //44/15E3016C800D/VXML:/vxml_vapp_vcr_control_disable:
May 18 18:57:50.841: //44/15E3016C800D/VXML:/vxml_s
HQ-RTR#tart:
vxmlhandle=47E34858 vapphandle=47E31A24 status=0 async_status=200000000
May 18 18:57:50.841: //-1//VXML:/vxml_media_done: Exit
May 18 18:57:50.841: //44//AFW_:/vapp_checksessionstate:
May 18 18:57:50.841: //44//AFW_:/vapp_checkifdone: Object: 2, Leg: 1
May 18 18:57:52.597: //44//AFW_:/vapp_driver: evtID: 200 vapp record state: 0
May 18 18:57:52.597: //44//AFW_:/vapp_do_bargein: Input=2
May 18 18:57:52.597: //44//AFW_:/vapp_digit_collection_done:
May 18 18:57:52.597: //44//AFW_:/vapp_digit_collection_done: digits [12345],
status [0], pattern []
May 18 18:57:52.597: //44/15E3016C800D/VXML:/vxml_digit_collection_done:
vxmlp 48479894 status 0 async_status 200000000
May 18 18:57:52.597: //44/15E3016C800D/VXML:/vxml_digit_collection_done:
digits (12345)
May 18 18:57:52.601: //44/15E3016C800D/VXML:/vxml_digit_collection_done:
name ()
May 18 18:57:52.601: //44/15E3016C800D/VXML:/vxml_bind_lastprompt:
May 18 18:57:52.601: //44/15E3016C800D/VXML:/vxml_digit_collect_process:
vxmlp 48479894 status 0 async_status 40000
May 18 18:57:52.601: //44/15E3016C800D/VXML:/vxml_start:
vxmlhandle=47E34858 vapphandle=47E31A24 status=0 async_status=40000
May 18 18:57:52.601: //44/15E3016C800D/VXML:/vxml_vxml_proc:
<vxml>
URI(abs):http://10.10.210.10:8080/ccmivr/IVRCalleridLookup.do?remotedest=2123942123&srcdir=en_US
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRCalleridLookup.do
query=remotedest=2123942123&srcdir=en_US
base=
URI(abs):http://10.10.210.10:8080/ccmivr/IVRCalleridLookup.do?remotedest=2123942123&srcdir=en_US
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRCalleridLookup.do
query=remotedest=2123942123&srcdir=en_US lang=none version=2.0
May 18 18:57:52.601: //-1//VXML:/vxml_field_proc: Enter
May 18 18:57:52.601: //44/15E3016C800D/VXML:/vxml_field_proc:
May 18 18:57:52.601: <field>: type=digits
May 18 18:57:52.601: //44/15E3016C800D/VXML:/vxml_item_attrs_proc:
name=pin modal=aai prompt_counter=2
May 18 18:57:52.601: //44/15E3016C800D/VXML:/vxml_filled_proc:
May 18 18:57:52.601: <filled>: mode=all
<var>: namep=ccmusername
May 18 18:57:52.605: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var ccmusername)
May 18 18:57:52.605: //44/15E3016C800D/VXML:/vxml_jse_global_switch:
switch to scope(anonymous)
May 18 18:57:52.605: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=ccmusername expr='hqph2'
May 18 18:57:52.605: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(ccmusername='hqph2')
<var>: namep=accessCount
May 18 18:57:52.605: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var accessCount)
May 18 18:57:52.605: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=accessCount expr='1'
May 18 18:57:52.605: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(accessCount='1')
<var>: namep=remotedest
May 18 18:57:52.609: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var remotedest)
May 18 18:57:52.609: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=remotedest expr='2123942123'
HQ-RTR#May 18 18:57:52.609: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(remotedest='2123942123')
<var>: namep=srcdir
May 18 18:57:52.609: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var srcdir)
May 18 18:57:52.609: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=srcdir expr='en_US'
May 18 18:57:52.613: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(srcdir='en_US')
May 18 18:57:52.613: //44/15E3016C800D/VXML:/vxml_if_proc:
<if>: cond=pin == '*'
May 18 18:57:52.613: //-
HQ-RTR#1//VXML:/vxml_submit_proc: Enter
May 18 18:57:52.613: //44/15E3016C800D/VXML:/vxml_submit_proc:
<submit>: caching=fast fetchhint=invalid fetchtimeout=0 maxage=-1
maxstale=-1
URI(abs):IVRPinLookup.do
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRPinLookup.do
May 18 18:57:52.613: //44/15E3016C800D/VXML:/vxml_sub_attrs_proc:
method=get
enctype=application/x-www-form-urlencoded
May 18 18:57:52.613: //44/15E3016C800D/VXML:/vxml_nmtokens_proc:
name=ccmusername
na
HQ-RTR#me=pin
name=remotedest
name=srcdir
name=accessCount
May 18 18:57:52.613: //-1//VXML:/vxml_sub_attrs_proc: Enter
May 18 18:57:52.613: //-1//VXML:/vxml_sub_attrs_proc: Exit
May 18 18:57:52.613: //44/15E3016C800D/VXML:/vxml_vapp_bgload_from_proc:
urlp=http://10.10.210.10:8080/ccmivr/IVRPinLookup.do?ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
fetchaudio=NULL delay=0 minimum=0
May 18 18:57:52.617: //44/15E3016C800D/VXML:/vxml_vapp_bgload:
url
http://10.10.210.10:8080/ccmivr/IVRPinLookup.do?ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
cachable 1 fetchtimeout 0 maxage=-1 maxstale=-1
May 18 18:57:52.617: //44//AFW_:/vapp_bgload:
url=http://10.10.210.10:8080/ccmivr/IVRPinLookup.do?ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
May 18 18:57:52.617: //44//AFW_:/vxml_update_cleanup_timer: cleaning timer
running 0 fetchtimeout 0
May 18 18:57:52.617: //-1//VXML:/vxml_vapp_bgload: Exit
May 18 18:57:52.617: //-1//VXML:/vxml_vapp_bgload_from_pro
HQ-RTR#c: normal_async_load, e...@8233
May 18 18:57:52.617: //-1//VXML:/vxml_submit_proc: Exit
May 18 18:57:52.617: //-1//VXML:/vxml_elem_proc:
(400000000) Status not OK, e...@9897
May 18 18:57:52.617: //-1//VXML:/vxml_if_proc:
(400000000) Status not OK, e...@5724
May 18 18:57:52.617: //-1//VXML:/vxml_elem_proc:
(400000000) Status not OK, e...@9897
May 18 18:57:52.617: //44/15E3016C800D/VXML:/vxml_leave_scope:
scope=anonymous
May 18 18:57:52.617: //-1//VXML:/vxml_form_filled:
(400000000) Status not OK, e...@5171
May 18 18:57:52.617: //-1//VXML:/vxml_form_filled:
(400000000) Status not OK, e...@5181
May 18 18:57:52.617: //-1//VXML:/vxml_form_filled:
(400000000) Status not OK, e...@5181
May 18 18:57:52.617: //-1//VXML:/vxml_form_filled:
(400000000) Status not OK, e...@5175
May 18 18:57:52.617: //-1//VXML:/vxml_form_filled:
(400000000) Status not OK, e...@5181
May 18 18:57:52.617: //-1//VXML:/vxml_form_filled:
(400000000) Status not OK, e...@5175
May 18 18:57:52.617: //-1//VXML:/vxml_field_proc: Input done, e...@4757
May 18 18:57:52.617: //-1//VXML:/vxml_elem_proc:
(400000000) Status not OK, e...@9897
May 18 18:57:52.617: //-1//VXML:/vxml_vxml_proc:
(400000000) Status not OK, e...@10103
May 18 18:57:52.617: //44/15E3016C800D/VXML:/vxml_load_immediate_done:
sidp->status=400000000
May 18 18:57:52.617: //-1//VXML:/vxml_digit_collection_done: Exit
May 18 18:57:52.617: //44//AFW_:/vapp_checksessionstate:
May 18 18:57:52.617: //44//AFW_:/vapp_checkifdone: Object: 1, Leg: 1
May 18 18:57:52.729: //44//HIFS:/hifs_http_cb: hif
HQ-RTR#s http read succeeded. size=2179,
url=http://10.10.210.10:8080/ccmivr/IVRPinLookup.do?ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
May 18 18:57:52.729: //44//AFW_:/vapp_bgload_done: status=No Error
May 18 18:57:52.729: //44//HIFS:/hifs_http_cb: hifs ifs file read succeeded.
size=2179,
url=http://10.10.210.10:8080/ccmivr/IVRPinLookup.do?ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
May 18 18:57:52.729: //44//HIFS:/hifs_free_idata: hifs_free_idata: 0x47C59F28
May 18 18:57:52.729: //44//HIFS:/hifs_hold_idata: hifs_hold_idata: 0x47C59F28
May 18 18:57:52.729: //44//AFW_:/vapp_driver: evtID: 220 vapp record state: 0
May 18 18:57:52.729: //44//AFW_:/vapp_bgload_done_event:
May 18 18:57:52.729: //44//AFW_:/vapp_bgload_done_event: length=2179, page
loaded=
<vxml version="2.0">
<form id="GetFunctionSel">
<grammar type="application/grammar+regex">.</grammar>
<field name="funcsel" type="digits?length=1">
<pro
May 18 18:57:52.729: //44/15E3016C800D/VXML:/vxml_is_doc:
vxml_is_doc
May 18 18:57:52.729: //-1//VXML:/vxml_tree_lock:
vxmlp=47E35714 usage_cnt=0
May 18 18:57:52.733: //0/15E3016C800D/VXML:/vxml_parse:
May 18 18:57:52.733: vxml_parse: XML_Parse success err=0
May 18 18:57:52.737: //0/15E3016C800D/VXML:/vxml_session_delete:
May 18 18:57:52.737: vxml_session_delete:mem_mgr_mempool_free: mempool=NULL
May 18 18:57:52.737: vxml_session_delete:mem_mgr_mempool_free: mempool=NULL
May 18 18:57:52.737: //-1//VXML:/vxml_crc_generate_element_tree: 43 crc
generated
May 18 18:57:52.737: //44/15E3016C800D/VXML:/vxml_bgload_post_done:
vxmlhandle=47E34858 status=0 async_status=400000000
May 18 18:57:52.737: //44/15E3016C800D/VXML:/vxml_bgload_post_done:
Loading file with url
(http://10.10.210.10:8080/ccmivr/IVRPinLookup.do?ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1)
May 18 18:57:52.737: //-1//VXML:/vxml_is_cisco_data: Enter
May 18 18:57:52.737: //44/15E3016C800D/VXML:/vxml_leave_scope:
scope=application
May
HQ-RTR#18 18:57:52.737: //-1//VXML:/vxml_crc_verify_element_tree: 23 crc
verified
May 18 18:57:52.741: //44/15E3016C800D/VXML:/vxml_tree_delete:
vxmlp=48479894, usage_cnt=1
url=http://10.10.210.10:8080/ccmivr/IVRCalleridLookup.do?remotedest=2123942123&srcdir=en_US
May 18 18:57:52.741: vxml_tree_delete:mem_mgr_mempool_free:
mem_refcnt(47E4F984)=0 - mempool cleanup
May 18 18:57:52.741: //44/15E3016C800D/VXML:/vxml_stop_fetchaudio:
May 18 18:57:52.741: //44/15E3016C800D/VXML:/vxml_start:
vxmlhandle=47E34858 vapphandle=47E31A24 status=0 async_status=80000
May 18 18:57:52.741: //44/15E3016C800D/VXML:/vxml_vxml_proc:
<vxml>
URI(abs):http://10.10.210.10:8080/ccmivr/IVRPinLookup.do?ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRPinLookup.do
query=ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
base=
URI(abs):http://10.10.210.10:8080/ccmivr/IVRPinLookup.do?ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRPinLookup.do
query=ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
lang=none version=2.0
May 18 18:57:52.741: //44/15E3016C800D/VXML:/vxml_form_proc:
May 18 18:57:52.741: <form>: id=GetFunctionSel scope=dialog
May 18 18:57:52.741: //44/15E3016C800D/VXML:/vxml_form_init:
current scope: dialog
vxml_counter_reset:
May 18 18:57:52.741: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var funcsel)
May 18 18:57:52.741: //44/15E3016C800D/VXML:/vxml_jse_global_switch:
switch to scope(dialog)
May 18 18:57:52.745: //44/15E3016C800D/VXML:/vxml_formitem_select:
Status=VXML_STATUS_OK,
May 18 18:57:52.745: //44/15E3016C800D/VXML:/vxml_formitem_select:
AsyncStatus=VXML_STATUS_OK
May 18 18:57:52.745: //-1//VXML:/vxml_field_proc: Enter
May 18 18:57:52.745: //44/15E3016C800D/VXML:/vxml_field_proc:
May 18 18:57:52.745: <field>: type=digits
May 18 18:57:52.745: //44/15E3016C800D/VXML:/vxml_item_attrs_proc:
name=funcsel modal=aai prompt_counter=1
May 18 18:57:52.745: //-1//VXML:/vxml_play_prompts: Enter
May 18 18:57:52.745: //-1//VXML:/vxml_prompt_proc: Enter
May 18 18:57:52.745: //44/15E3016C800D/VXML:/vxml_prompt_proc:
<prompt>: typeaheadflush=0 alternative=0
May 18 18:57:52.745: //-1//VXML:/vxml_process_prompt: Enter
May 18 18:57:52.745: //-1//VXML:/vxml_audio_proc: Enter
May 18 18:57:52.745: //44/15E3016C800D/VXML:/vxml_audio_proc:
<audio>:
URI(abs):IVRGetA
HQ-RTR#udioFile.do?srcdir=en_US&file=10.au
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRGetAudioFile.do
query=srcdir=en_US&file=10.au caching=fast fetchhint=invalid fetchtimeout=0
maxage=-1 maxstale=-1
May 18 18:57:52.745: //-1//VXML:/vxml_audio_proc: Exit
May 18 18:57:52.745: //-1//VXML:/vxml_finish_generate_prompt_list: Enter
May 18 18:57:52.745: //-1//VXML:/vxml_finish_generate_prompt_list: Exit
May 18 18:57:52.745: //-1//VXML:/vxml_process_prompt: Exit
May 18 18:57:52.745: //44/15E3016C800D/VXML:/vxml_vapp_media_play:
bargein=1 timeout=0 typeaheadflush=0 vcr=0 rate=0 alternative=0 hotword=0
maxtime=0
May 18 18:57:52.745: //44/15E3016C800D/VXML:/vxml_vapp_media_play:
str=http://10.10.210.10:8080/ccmivr/IVRGetAudioFile.do?srcdir=en_US&file=10.au
cachable=1 timeout0 maxage=-1 maxstale=-1 codec=-1
May 18 18:57:52.745: //44//AFW_:/vapp_media_play:
May 18 18:57:52.745: //44//AFW_:/vapp_media_play:
prompt=http://10.10.210.10:8080/ccmivr/IVRGetAudioFile.do?srcdir=en_US&file=10.au:
May 18 18:57:52.745: //-1//VXML:/vxml_vapp_media_play: Exit
May 18 18:57:52.745: //-1//VXML:/vxml_prompt_proc: Exit
May 18 18:57:52.749: //-1//VXML:/vxml_play_prompts: Exit
May 18 18:57:52.749: //-1//VXML:/vxml_generic_digit_collect: Enter
May 18 18:57:52.749: //44/15E3016C800D/VXML:/vxml_vapp_digit_collect:
termchar # minlength 0 maxlength 0 timeout 15000 interdigittimeout 10000
numPatterns=1hotword 0 abortKey
May 18 18:57:52.749: //44//AFW_:/vapp_digit_collect:
May 18 18:57:52.749: //44//AFW_:/vapp_digit_collect: numPatterns 1, minlength
0, maxlength 0, timeout 15000, interDigitTimeout 10000 hotword 0
May 18 18:57:52.749: //-1//VXML:/vxml_vapp_digit_collect: Exit
May 18 18:57:52.749: //-1//VXML:/vxml_generic_digit_collect: Exit
May 18 18:57:52.749: //-1//VXML:/vxml_field_proc: Exit
May 18 18:57:52.749: //-1//VXML:/vxml_elem_proc:
(300000000) Status not OK, e...@9897
May 18 18:57:52.749: //-1//VXML:/vxml_formitem_select:
(300000000) Status not OK, e...@5383
May 18 18:57:52.749: //-1//VXML:/vxml_form_proc:
(300000000) Status not OK, e...@5535
May 18 18:57:52.749: //-1//VXML:/vxml_elem_proc:
(300000000) Status not OK, e...@9897
May 18 18:57:52.749: //-1//VXML:/vxml_vxml_proc:
(300000000) Status not OK, e...@10094
May 18 18:57:52.749: //44/15E3016C800D/VXML:/vxml_load_immediate_done:
sidp->status=300000000
May 18 18:57:52.749: //-1//VXML:/vxml_bgload_post_done: Async load, e...@6757
May 18 18:57:52.749: //-1//VXML:/vxml_bgload_post_done: return
May 18 18:57:52.749: //44//AFW_:/vapp_checksessionstate:
May 18 18:57:52.749: //44//AFW_:/vapp_checkifdone: Object: 2, Leg: 1
May 18 18:57:54.145: //44//AFW_:/vapp_driver: evtID: 200 vapp record state: 0
May 18 18:57:54.145: //44//AFW_:/vapp_do_bargein: Input=2
May 18 18:57:54.145: //44//AFW_:/vapp_digit_collection_done:
May 18 18:57:54.145: //44//AFW_:/vapp_digit_collection_done: digits [1], status
[0], pattern [v0]
May 18 18:57:54.145: //44/15E3016C800D/VXML:/vxml_digit_collection_done:
vxmlp 47E35714 status 0 async_status 300000000
May 18 18:57:54.145: //44/15E3016C800D/VXML:/vxml_digit_collection_done:
digits (1)
May
HQ-RTR#18 18:57:54.145: //44/15E3016C800D/VXML:/vxml_digit_collection_done:
name (v0)
May 18 18:57:54.145: //44/15E3016C800D/VXML:/vxml_bind_lastprompt:
May 18 18:57:54.145: //-1//VXML:/vxml_digit_collection_done: Media in play,
e...@6991
May 18 18:57:54.145: //44//AFW_:/vapp_checksessionstate:
May 18 18:57:54.145: //44//AFW_:/vapp_checkifdone: Object: 1, Leg: 1
May 18 18:57:54.149: //44//AFW_:/vapp_driver: evtID: 156 vapp record state: 0
May 18 18:57:54.149: //44//AFW_:/vapp_play_done: evID=156 reason=11, protocol=
HQ-RTR#2, status_code=0, dur=1240, rate=0
May 18 18:57:54.149: //44/15E3016C800D/VXML:/vxml_media_done:
status 18 async_status 100040000 duration=1240 rate=0
May 18 18:57:54.149: //44/15E3016C800D/VXML:/vxml_save_lastprompt_info:
May 18 18:57:54.149: //44/15E3016C800D/VXML:/vxml_save_lastprompt_info:
May 18 18:57:54.149: //44//AFW_:/vapp_notify_play_done:
May 18 18:57:54.149: //44/15E3016C800D/VXML:/vxml_vapp_vcr_control_disable:
May 18 18:57:54.149: //44/15E3016C800D/VXML:/vxml_bind_lastprompt:
May 18 18:57:54.149: //44/15E3016C800D/VXML:/vxml_digit_collect_process:
vxmlp 47E35714 status 0 async_status 40000
May 18 18:57:54.149: //44/15E3016C800D/VXML:/vxml_start:
vxmlhandle=47E34858 vapphandle=47E31A24 status=0 async_status=40000
May 18 18:57:54.149: //44/15E3016C800D/VXML:/vxml_vxml_proc:
<vxml>
URI(abs):http://10.10.210.10:8080/ccmivr/IVRPinLookup.do?ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
scheme=http
host=10.10.210.10
port=8080
path=
HQ-RTR#/ccmivr/IVRPinLookup.do
query=ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
base=
URI(abs):http://10.10.210.10:8080/ccmivr/IVRPinLookup.do?ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRPinLookup.do
query=ccmusername=hqph2&pin=12345&remotedest=2123942123&srcdir=en_US&accessCount=1
lang=none version=2.0
May 18 18:57:54.149: //-1//VXML:/vxml_field_proc: Enter
May 18 18:57:54.149: //44/15E3016C800D/VXML:/vxml_field_proc:
May 18 18:57:54.149: <field>: type=digits
May 18 18:57:54.149: //44/15E3016C800D/VXML:/vxml_item_attrs_proc:
name=funcsel modal=aai prompt_counter=2
May 18 18:57:54.153: //44/15E3016C800D/VXML:/vxml_filled_proc:
May 18 18:57:54.153: <filled>: mode=all
<var>: namep=edtVal
May 18 18:57:54.153: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var edtVal)
May 18 18:57:54.153: //44/15E3016C800D/VXML:/vxml_jse_global_switch:
switch to scope(anonymous)
May 18 18:57:54.153: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=edtVal expr='success'
May 18 18:57:54.153: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(edtVal='success')
<var>: namep=ccmusername
May 18 18:57:54.153: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var ccmusername)
May 18 18:57:54.157: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=ccmusername expr='hqph2'
May 18 18:57:54.157: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(ccmusername='hqph2')
<var>: namep=remotedest
May 18 18:57:54.157: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var remotedest)
May 18 18:57:54.157: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=remotedest expr='2123942123'
May 18 18:57:54.157: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(remotedest='2123942123')
<var>: namep=srcdir
May 18 18:57:54.157: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var srcdir)
May 18 18:57:54.161: //44/15E3016C800D/VXML:/vxml_assign_pro
HQ-RTR#c:
<assign>: name=srcdir expr='en_US'
May 18 18:57:54.161: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(srcdir='en_US')
May 18 18:57:54.161: //44/15E3016C800D/VXML:/vxml_if_proc:
<if>: cond=funcsel=='1'
May 18 18:57:54.161: //44/15E3016C800D/VXML:/vxml_if_proc:
<if>: cond=edtVal == 'success'
May 18 18:57:54.165: //-1//VXML:/vxml_submit_proc: Enter
May 18 18:57:54.165: //44/15E3016C800D/VXML:/vxml_submit_proc:
<submit>: caching=fast fetchhint=invalid fetchtimeout=0
maxage=-1 maxstale=-1
URI(abs):IVRProcessLineApp.do
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRProcessLineApp.do
May 18 18:57:54.165: //44/15E3016C800D/VXML:/vxml_sub_attrs_proc:
method=get
enctype=application/x-www-form-urlencoded
May 18 18:57:54.165: //44/15E3016C800D/VXML:/vxml_nmtokens_proc:
name=ccmusername
name=funcsel
name=remotedest
name=srcdir
May 18 18:57:54.165: //-1//VXML:/vxml_sub_attrs_proc: Enter
May 18 18:57:54.165: //-1//VXML:/vxml_sub_attrs_proc: Exit
May 18 18:57:54.165: //44/15E3016C800D/VXML:/vxml_vapp_bgload_from_proc:
urlp=http://10.10.210.10:8080/ccmivr/IVRProcessLineApp.do?ccmusername=hqph2&funcsel=1&remotedest=2123942123&srcdir=en_US
fetchaudio=NULL delay=0 minimum=0
May 18 18:57:54.165: //44/15E3016C800D/VXML:/vxml_vapp_bgload:
url
http://10.10.210.10:8080/ccmivr/IVRProcessLineApp.do?ccmusername=hqph2&funcsel=1&remotedest=2123942123&srcdir=en_US
cachable 1 fetchtimeout 0 maxage=-1 maxstale=-1
May 18 18:57:54.165: //44//AFW_:/vapp_bgload:
url=http://10.10.210.10:8080/ccmivr/IVRProcessLineApp.do?ccmusername=hqph2&funcsel=1&remotedest=2123942123&srcdir=en_US
May 18 18:57:54.165: //44//AFW_:/vxml_update_cleanup_timer: cleaning timer
running 0 fetchtimeout 0
May 18 18:57:54.165: //-1//VXML:/vxml_vapp_bgload: Exit
May 18 18:57:54.165: //-1//VXML:/vxml_vapp_bgload_from_proc: normal_async_load,
e...@8233
May 18 18:57:54.165: //-1//VXML:/vxml_submit_proc: Exit
May 18 18:57:54.165: //-1//VXML:/vxml_elem_proc:
(400000000) Status not OK, e...@9897
May 18 18:57:54.165: //-1//VXML:/vxml_if_proc:
(400000000) Status not OK, e...@5724
May 18 18:57:54.165: //-1//VXML:/vxml_elem_proc:
(400000000) Status not OK, e...@9897
May 18 18:57:54.165: //-1//VXML:/vxml_if_proc:
(400000000) Status not OK, e...@5724
May 18 18:57:54.169: //-1//VXML:/vxml_elem_proc:
(400000000) Status not OK, e...@9897
May 18 18:57:54.169: //44/15E3016C800D/VXML:/vxml_leave_scope:
scope=anonymous
May 18 18:57:54.169: //-1//VXML:/vxml_form_filled:
(400000000) Status not OK, e...@5171
May 18 18:57:54.
HQ-RTR#169: //-1//VXML:/vxml_form_filled:
(400000000) Status not OK, e...@5181
May 18 18:57:54.169: //-1//VXML:/vxml_form_filled:
(400000000) Status not OK, e...@5181
May 18 18:57:54.169: //-1//VXML:/vxml_form_filled:
(400000000) Status not OK, e...@5175
May 18 18:57:54.169: //-1//VXML:/vxml_form_filled:
(400000000) Status not OK, e...@5181
May 18 18:57:54.169: //-1//VXML:/vxml_form_filled:
(400000000) Status not OK, e...@5175
May 18 18:57:54.169: //-1//VXML:/vxml_field_proc: Input done, e...@4757
May 18 18:57:54.169: //-1//VXML:/vxml_elem_proc:
(400000000) Status not OK, e...@9897
May 18 18:57:54.169: //-1//VXML:/vxml_vxml_proc:
(400000000) Status not OK, e...@10103
May 18 18:57:54.169: //44/15E3016C800D/VXML:/vxml_load_immediate_done:
sidp->status=400000000
May 18 18:57:54.169: //44//AFW_:/vapp_checksessionstate:
May 18 18:57:54.169: //44//AFW_:/vapp_checkifdone: Object: 1, Leg: 1
May 18 18:57:54.181: //44//HIFS:/hifs_http_cb: hifs http read succeeded.
size=1025,
url=http://10.10.210.10:8080/ccmivr/IVRProcessLineApp.do?ccmusername=hqph2&funcsel=1&remotedest=2123942123&srcdir=en_US
May 18 18:57:54.181: //44//AFW_:/vapp_bgload_done: status=No Error
May 18 18:57:54.181: //44//HIFS:/hifs_http_cb: hifs ifs file read succeeded.
size=1025,
url=http://10.10.210.10:8080/ccmivr/IVRProcessLineApp.do?ccmusername=hqph2&funcsel=1&remotedest=2123942123&srcdir=en_US
May 18 18:57:54.181: //44//HIFS:/hifs_free_idata: hifs_free_idata: 0x47C56964
May 18 18:57:54.181: //44//HIFS:/hifs_hold_idata: hifs_hold_idata: 0x47C56964
May 18 18:57:54.185: //44//AFW_:/vapp_driver: evtID: 220 vapp record state: 0
May 18 18:57:54.185: //44//AFW_:/vapp_bgload_done_event:
May 18 18:57:54.185: //44//AFW_:/vapp_bgload_done_event: length=1025, page
loaded=
<vxml version="2.0">
<form id="Getdialno">
<grammar type="application/grammar+regex">.</grammar>
<field name="dialno" type="digits?minlength=1;maxlength=50">
<prompt>
May 18 18:57:54.185: //44/15E3016C800D/VXML:/vxml_is_doc:
vxml_is_doc
May 18 18:57:54.185: //-1//VXML:/vxml_tree_lock:
vxmlp=48479894 usage_cnt=0
May 18 18:57:54.185: //0/15E3016C800D/VXML:/vxml_parse:
May 18 18:57:54.185: vxml_parse: XML_Parse success err=0
May 18 18:57:54.185: //0/15E3016C800D/VXML:/vxml_session_delete:
May 18 18:57:54.189: vxml_session_delete:mem_mgr_mempool_free: mempool=NULL
May 18 18:57:54.189: vxml_session_delete:mem_mgr_mempool_free: mempool=NULL
May 18 18:57:54.189: //-1//VXML:/vxml_crc_generate_element_tree: 21 crc
generated
May 18 18:57:54.189: //44/15E3016C800D/VXML:/vxml_bgload_post_done:
vxmlhandle=47E34858 status=0 async_status=400000000
May 18 18:57:54.189: //44/15E3016C800D/VXML:/vxml_bgload_post_done:
Loading file with url
(http://10.10.210.10:8080/ccmivr/IVRProcessLineApp.do?ccmusername=hqph2&funcsel=1&remotedest=2123942123&srcdir=en_US)
May 18 18:57:54.189: //-1//VXML:/vxml_is_cisco_data: Enter
May 18 18:57:54.189: //44/15E3016C800D/VXML:/vxml_leave_scope:
scope=application
May 18 18:57:54.285: %ISDN-6-CONNECT: Interface Serial0/1/0:0 is now connected
to 2123942123 N/A
May 18 18:57:55.901
HQ-RTR#: //44//AFW_:/vapp_driver: evtID: 156 vapp record state: 0
May 18 18:57:55.901: //44//AFW_:/vapp_play_done: evID=156 reason=11,
protocol=2, status_code=0, dur=1640, rate=0
May 18 18:57:55.901: //44/15E3016C800D/VXML:/vxml_media_done:
status 18 async_status 300000000 duration=1640 rate=0
May 18 18:57:55.901: //44/15E3016C800D/VXML:/vxml_save_lastprompt_info:
May 18 18:57:55.901: //44//AFW_:/vapp_bargein_digit_collect_done:
May 18 18:57:55.901: //44/15E3016C800D/VXML:/vxml_save_lastprompt_info:
May 18 18:57:55.901: //44//AFW_:/vapp_notify_play_done:
May 18 18:57:55.901: //44/15E3016C800D/VXML:/vxml_vapp_vcr_control_disable:
May 18 18:57:55.901: //44/15E3016C800D/VXML:/vxml_start:
vxmlhandle=47E34858 vapphandle=47E31A24 status=0 async_status=200000000
May 18 18:57:55.901: //-1//VXML:/vxml_media_done: Exit
May 18 18:57:55.901: //44//AFW_:/vapp_checksessionstate:
May 18 18:57:55.901: //44//AFW_:/vapp_checkifdone: Object: 2, Leg: 1
May 18 18:57:57.617: //44//AFW_:/vapp_driver: evtID: 200 vapp record state: 0
May 18 18:57:57.617: //44//AFW_:/vapp_do_bargein: Input=2
May 18 18:57:57.617: //44//AFW_:/vapp_digit_collection_done:
May 18 18:57:57.617: //44//AFW_:/vapp_digit_collection_done: digits [1002],
status [0], pattern []
May 18 18:57:57.617: //44/15E3016C800D/VXML:/vxml_digit_collection_done:
vxmlp 48479894 status 0 async_status 200000000
May 18 18:57:57.617: //44/15E3016C800D/VXML:/vxml_digit_collection_done:
digits (1002)
May 18 18:57:57.617: //44/15E3016C800D/VXML:/vxml_digit_collection_done:
name ()
May 18 18:57:57.617: //44/15E3016C800D/VXML:/vxml_bind_lastprompt:
May 18 18:57:57.621: //44/15E3016C800D/VXML:/vxml_digit_collect_process:
vxmlp 48479894 status 0 async_status 40000
May 18 18:57:57.621: //44/15E3016C800D/VXML:/vxml_start:
vxmlhandle=47E34858 vapphandle=47E31A24 status=0 async_status=40000
May 18 18:57:57.621: //44/15E3016C800D/VXML:/vxml_vxml_proc:
<vxml>
URI(abs):http://10.10.210.10:8080/ccmivr/IVRProcessLineApp.do?ccmusername=hqph2&funcsel=1&remotedest=2123942123&srcdir=en_US
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRProcessLineApp.do
query=ccmusername=hqph2&funcsel=1&remotedest=2123942123&srcdir=en_US
base=
URI(abs):http://10.10.210.10:8080/ccmivr/IVRProcessLineApp.do?ccmusername=hqph2&funcsel=1&remotedest=2123942123&srcdir=en_US
scheme=http
host=10.10.210.10
port=8080
path=/ccmivr/IVRProcessLineApp.do
query=ccmusername=hqph2&funcsel=1&remotedest=2123942123&srcdir=en_US
lang=none version=2.0
May 18 18:57:57.621: //-1//VXML:/vxml_field_proc: Enter
May 18 18:57:57.621: //44/15E3016C800D/VXML:/vxml_field_proc:
May 18 18:57:57.621: <field>: type=digits
May 18 18:57:57.621: //44/15E3016C800D/VXML:/vxml_item_attrs_proc:
name=dialno modal=aai prompt_counter=2
May 18 18:57:57.621: //44/15E3016C800D/VXML:/vxml_filled_proc:
May 18 18:57:57.621: <filled>: mode=all
<var>: namep=remotedest
May 18 18:57:57.621: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var remotedest)
May 18 18:57:57.621: //44/15E3016C800D/VXML:/vxml_jse_global_switch:
switch to scope(anonymous)
May 18 18:57:57.625: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=remotedest expr='2123942123'
May 18 18:57:57.625: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(remotedest='2123942123')
<var>: namep=ccmusername
May 18 18:57:57.625: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var ccmusername)
May 18 18:57:57.625: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=ccmusername expr='hqph2'
May 18 18:57:57.625: //44/15E
HQ-RTR#3016C800D/VXML:/vxml_expr_eval:
expr=(ccmusername='hqph2')
<var>: namep=funcsel
May 18 18:57:57.629: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var funcsel)
May 18 18:57:57.629: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=funcsel expr='1'
May 18 18:57:57.629: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(funcsel='1')
<var>: namep=srcdir
May 18 18:57:57.629: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var srcdir)
May 18 18:57:57.629: //44/15E3016C800D/VXML:/vxml_assign_proc:
<assign>: name=srcdir expr='en_US'
May 18 18:57:57.685: //44//VXML:/vapp_evt_placecall:
May 18 18:57:57.685: //44//VXML:/vapp_evt_placecall: GTD to CallSetup= 0x0
May 18 18:57:57.685: //44//VXML:/vapp_evt_placecall: transfer_mode=, CSMode=0
May 18 18:57:57.717: //44//VXML:/ContactingDest_ProcessGTD:
May 18 18:57:57.741: CNG tone sent
May 18 18:58:00.205: %ISDN-6-DISCONNECT: Interface Serial0/1/0:0 disconnected
from 2123942123 , call lasted 11 seconds
May 18 18:58:00.209: //44//AFW_:/vapp_driver: evtID: 17 vapp record state: 0
May 18 18:58:00.209: //44//AFW_:/vapp_call_disconnected: fetchtimeout 0
May 18 18:58:00.209: //44//AFW_:/vapp_add_disconnected_gtd: Add GTD from
disconnected event
May 18 18:58:00.209: //44//AFW_:/vapp_call_disconnected: transfer in progress,
hang on till setupdone
May 18 18:58:00.209: //44//AFW_:/vapp_checksessionstate:
May 18 18:58:00.209: //44//AFW_:/vapp_checkifdone: Object: 1, Leg: 1
May 18 18:58:00.217: //44//VXML:/ContactingDest_SetupDone:
May 18 18:58:00.221: //44//VXML:/ContactingDest_SetupDone: Setup done status =
CS_INTWRKLEG_DISCONNECT
May 18 18:58:00.221: //44/15E3016C800D/VXML:/vxml_user_hangup:
duration 0 status=B async_status=80000000
May 18 18:58:00.221: //44/15E3016C800D/VXML:/vxml_event_proc:
<event>: event=connection.disconnect.hangup status=0
May 18 18:58:00.221: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var _event='connection.disconnect.hangup')
May 18 18:58:00.221: //44/15E3016C800D/VXML:/vxml_expr_eval:
expr=(var _message=undefined)
May 18 18:58:00.221: //44/15E3016C800D/VXML:/vxml_default_event_handler:
use default event handler
May 18 18:58:00.221: //44//AFW_:/vapp_session_exit_event_name: Exit Event
connection.disconnect.hangup
May 18 18:58:00.221: //44/15E3016C800D/VXML:/vxml_load_immediate_done:
sidp->status=10
May 18 18:58:00.221: //44/15E3016C800D/VXML:/vxml_start:
vxmlhandle=47E34858 vapphandle=47E31A24 status=0 async_status=10
May 18 18:58:00.221: //44/15E3016C800D/VXML:/vxml_throw_error_session_event:
async_status=10
May 18 18:58:00.221: //44/15E3016C800D/VXML:/vxml_vapp_terminate:
vapp_status=0 ref_count 0
May 18 18:58:00.221: //44//AFW_:/vapp_terminate:
May 18 18:58:00.221: //44//AFW_:/AFW_M_VxmlModule_Terminate:
May 18 18:58:00.225: //44//AFW_:/vapp_checksessionstate:
May 18 18:58:00.225: //44//AFW_:/vapp_checkifdone: Object: 1, Leg: 1
May 18 18:58:00.225: //-1//VXML:/vxml_destroy: Enter
May 18 18:58:00.229: //-1//VXML:/vxml_crc_verify_element_tree: 15 crc verified
May 18 18:58:00.229: //44/15E3016C800D/VXML:/vxml_tree_delete:
vxmlp=47E35714, usage_cnt=1
url=http://10.10.210.10:8080/ccmivr/IVRPlaceCall.do?ccmusername=hqph2&remotedest=2123942123&dialno=1002&srcdir=en_US
May 18 18:58:00.229: vxml_tree_delete:mem_mgr_mempool_free:
mem_refcnt(47E4F984)=0 - mempool cleanup
May 18 18:58:00.229: //44/15E3016C800D/VXML:/vxml_session_delete:
May 18 18:58:00.229: vxml_session_delete:mem_mgr_mempool_free:
mem_refcnt(47E347DC)=0 - mempool cleanup
May 18 18:58:00.229: vxml_session_delete:mem_mgr_mempool_free: mempool=NULL
May 18 18:58:00.229: //-1//VXML:/vxml_destroy: Exit
May 18 18:58:00.233: //-1//VXML:/vxml_vapp_terminate: Exit
May 18 18:58:00.233: //-1//VXML:/vxml_start: Exit
May 18 18:58:00.233: //-1//VXML:/vxml_user_hangup: Exit
May 18 18:58:00.233: //-1//AFW_:HN0035BE58:/AFW_M_VxmlModule_Free:
May 18 18:58:00.233: MOD[VxmlModule_47E31A24_0_3522136] ( )
HQ-RTR#
HQ-RTR#
HQ-RTR#
HQ-RTR#un all
All possible debugging has been turned off
_______________________________________________
For more information regarding industry leading CCIE Lab training, please visit
www.ipexpert.com