topic Re: TCL example its-CISCO issue in Call Control

TCL example its-CISCO issue

jvazquez — Thu, 25 Feb 2016 19:30:17 GMT

Hello i trying to use example its-CISCO and i getting next error .. any idea ??? general configure information below error

thanks in advence

*Feb 25 19:38:36.547: //187//TCL :/tcl_PutsObjCmd: proc act_Setup

*Feb 25 19:38:36.547:

*Feb 25 19:38:36.547: //187//TCL :/tcl_PutsObjCmd:

proc init_perCallvars

*Feb 25 19:38:36.551:

*Feb 25 19:38:36.551: //187//TCL :/tcl_PutsObjCmd:

ANI sip:30110@172.20.5.22

*Feb 25 19:38:36.551:

*Feb 25 19:38:36.551: //187//TCL :/tcl_PutsObjCmd:

DNIS sip:5555@172.20.5.30:5060

*Feb 25 19:38:36.551:

*Feb 25 19:38:36.551: //-1//AFW_:/AFW_Util_GetUsrContainerData: Container is present, No data

*Feb 25 19:38:36.551: //-1//AFW_:/AFW_Util_CopyLegServiceCodeToCallInfoContainer: Service Code not available on Leg

*Feb 25 19:38:36.551: //-1//AFW_:/AFW_Util_CopyLegRouteCodeToCallInfoContainer: Route Code not available on Leg

*Feb 25 19:38:36.551: //-1//AFW_:/AFW_Util_GetTgCicValue: CIC Not found for tag(56)

*Feb 25 19:38:36.555: //-1//AFW_:/AFW_Util_CopyMLPPDataToCallInfoContainer: Voice MLPP not configured

*Feb 25 19:38:36.559: //187//TCL :/tcl_PutsObjCmd:

Call failed. Play prompt and collect digit

*Feb 25 19:38:36.559:

*Feb 25 19:38:36.563: //187//TCL :/tcl_PutsObjCmd:

proc act_Select

*Feb 25 19:38:36.563:

*Feb 25 19:38:36.563: //187//TCL :/tcl_PutsObjCmd:

proc act_DestBusy

*Feb 25 19:38:36.563:

*Feb 25 19:38:36.567: //187/EC1D68000000/SIP/Error/sipSPI_ipip_set_history_info_header: Not SIP2SIP mode

SIP: (187) Group (a= group line) attribute, level 65535 instance 1 not found.

SIP: Attribute mid, level 1 instance 1 not found.

*Feb 25 19:38:36.587: //187/EC1D68000000/SIP/Error/sipSPIProcessAckMedia: Could not modify QoS params for midca

-----

service test its-CISCO.tcl

paramspace english index 1

paramspace english lenguage en

paramspace english location flash:

param aa-pilot 5555

param operator 9998

------

dial peer

dial-peer voice 5555 voip

service test

session protocol sipv2

incoming called-number 5555

dtmf-relay rtp-nte

codec g711ulaw

no vad

---

GW version 151-4.M10

Re: TCL example its-CISCO issue

yawming — Thu, 25 Feb 2016 20:21:07 GMT

The sample script is not a ready to run you may need to modify according you the network environment.

There are several versions of that script, can you please attach the script you have ?

Thanks !

Re: TCL example its-CISCO issue

jvazquez — Thu, 25 Feb 2016 20:34:11 GMT

thanks,

this is the scrip that im using

# Script Locked by: khom

# Script Version: 2.0.2.0

# Script Name: its_CISCO

# Script Lock Date: Wed Jul 2 09:22:04 2003

#------------------------------------------------------------------

# November 27, 2001, Satish Ananthanarayana (sanantha@cisco.com)

# Modification History:

# --------------------

# May 20, 2008, Jasmine Kalaiselvan (jkalaise@cisco.com)

# Modified the script to do leg setup and then handovers the call

# to Default IOS app. DDTS for this change: CSCsq35953 CSCsl08148

# --------------------------------------------------------

#------------------------------------------------------------------

# Description:

# This is a TCL IVR script for the IOS Telephony Service and

# Call Manager (CM) offload scenario. The IVR script plays a

# welcome prompt to the user and prompts the user to enter a

# destination number when the user dials the auto-attendant number

# (aa-pilot configured in the CLI). The script collects the digits that

# the user has entered and hands the call to the enhanced session

# application (named Default). The session application

# returns once there is a disconnect (if the call is established)

# or if a call setup problem occurs.

# The operator support is also included, if the user does not dial

# any number or enters "0" the user will be transfered to an operator

# (if operator number is configured in the CLI). If the user enters

# an invalid number, the user will be prompted again to re-enter

# the number for upto 3 times before disconnecting the call.

#-------------------------------------------------------------------

proc init { } {

global param1

global selectCnt

global callInfo

global legConnected

global maxExtensionLen

set param1(interruptPrompt) true

set param1(abortKey) *

set param1(terminationKey) #

set selectCnt 0

set legConnected false

}

proc init_ConfigVars { } {

global destination

global aaPilot

global oprtr

global maxExtensionLen

# aa-pilot is the IVR number configured on the gateway to be used by the customer

# operator is the operator number for assisted calling

if [infotag get cfg_avpair_exists aa-pilot] {

set aaPilot [string trim [infotag get cfg_avpair aa-pilot]]

} else {

set aaPilot "NONE"

}

if [infotag get cfg_avpair_exists operator] {

set oprtr [string trim [infotag get cfg_avpair operator]]

} else {

set oprtr "NONE"

}

if [infotag get cfg_avpair_exists max-extension-length] {

set maxExtensionLen [string trim [infotag get cfg_avpair max-extension-length]]

if { $maxExtensionLen < 0 } {

call close

}

} else {

set maxExtensionLen 5

}

proc init_perCallVars { } {

puts "\nproc init_perCallvars"

global ani

global digit_enabled

global fcnt

global retrycnt

global dnis

set fcnt 0

set retrycnt 6

set ani ""

set dnis ""

set digit_enabled "FALSE"

set ani [infotag get leg_ani]

puts "\nANI $ani"

set dnis [infotag get leg_dnis]

puts "\nDNIS $dnis"

}

proc act_Setup { } {

global param1

global selectCnt

global dest

global beep

global callInfo

global dnis

global fcnt

global aaPilot

global oprtr

global busyPrompt

global legConnected

puts "proc act_Setup"

set busyPrompt _dest_unreachable.au

set beep 0

init_perCallVars

infotag set med_language 1

if { ($dnis == "") || ($dnis == $aaPilot) } {

leg setupack leg_incoming

leg proceeding leg_incoming

leg connect leg_incoming

set legConnected true

puts "\nNo DNIS\n"

set param1(dialPlan) true

leg collectdigits leg_incoming param1

media play leg_incoming _welcome.au %s1000 _enter_dest.au

} else {

set fcnt 6

leg setupack leg_incoming

#handoff callappl leg_incoming default "DESTINATION=$dnis"

set callInfo(alertTime) 30

leg setup $dnis callInfo leg_incoming

fsm setstate HANDOFF

}

proc act_GotDest { } {

global dest

global maxExtensionLen

global destExtLen

global callInfo

global oprtr

global busyPrompt

puts "\n proc act_GotDest"

set status [infotag get evt_status]

set callInfo(alertTime) 30

puts "\n STATUS: $status"

puts "\n MAXEXTENSION: $maxExtensionLen"

if { ($status == "cd_004") } {

set dest [infotag get evt_dcdigits]

set destExtLen [string length $dest]

puts "\n DESTLEN: $destExtLen"

set extLength [expr $maxExtensionLen - $destExtLen]

if { $dest == "0" } {

set dest $oprtr

}

puts "\n extLength: $extLength"

#handoff callappl leg_incoming default "DESTINATION=$dest"

if {($maxExtensionLen > 0) && ($extLength >= 0)} {

leg setup $dest callInfo leg_incoming

} else {

set busyPrompt _bacd_invalidoption.au

act_Select

}

} elseif { ($status == "cd_001") || ($status == "cd_002") } {

set dest $oprtr

#handoff callappl leg_incoming default "DESTINATION=$dest"

leg setup $dest callInfo leg_incoming

} else {

if { $status == "cd_006" } {

set busyPrompt _dest_unreachable.au

}

puts "\nCall [infotag get con_all] got event $status collecting destination"

set dest [infotag get evt_dcdigits]

if { $dest == "0" } {

set dest $oprtr

#handoff callappl leg_incoming default "DESTINATION=$dest"

leg setup $dest callInfo leg_incoming

} else {

act_Select

}

proc act_CallSetupDone { } {

global busyPrompt

global legConnected

set status [infotag get evt_status]

if { $status == "ls_000" } {

puts "\n Connection success"

handoff appl leg_all default

act_Cleanup

} else {

if { $legConnected == "false" } {

leg proceeding leg_incoming

leg connect leg_incoming

set legConnected true

}

puts "\n Call failed. Play prompt and collect digit"

if { ($status == "ls_007") } {

set busyPrompt _dest_busy.au

}

act_Select

}

proc act_Select { } {

global destination

global promptFlag2

global destBusy

global param1

global fcnt

global retrycnt

global busyPrompt

puts "\n proc act_Select"

set promptFlag2 0

set param1(interruptPrompt) true

set param1(abortKey) *

set param1(terminationKey) #

set param1(dialPlan) true

set param1(dialPlanTerm) true

leg collectdigits leg_incoming param1

if { $fcnt < $retrycnt } {

media play leg_incoming $busyPrompt %s500 _reenter_dest.au

incr fcnt

fsm setstate GETDEST

} else {

act_DestBusy

}

proc act_DestBusy { } {

puts "\n proc act_DestBusy"

media play leg_incoming _disconnect.au

fsm setstate CALLDISCONNECT

}

proc act_Cleanup { } {

call close

}

requiredversion 2.0

init

init_ConfigVars

#----------------------------------

# State Machine

#----------------------------------

set fsm(any_state,ev_disconnected) "act_Cleanup same_state"

set fsm(any_state,ev_disconnect_done) "act_Cleanup same_state"

set fsm(CALL_INIT,ev_setup_indication) "act_Setup GETDEST"

set fsm(GETDEST,ev_collectdigits_done) "act_GotDest HANDOFF"

#set fsm(HANDOFF,ev_returned) "act_CallSetupDone CONTINUE"

set fsm(HANDOFF,ev_setup_done) "act_CallSetupDone CONTINUE"

set fsm(CALLDISCONNECT,ev_media_done) "act_Cleanup same_state"

fsm define fsm CALL_INIT

# Script Approval Signature: C/775c

Also here is a detail debug..

*Feb 25 20:46:54.475: //-1/76B695000000/CCAPI/cc_api_display_ie_subfields:

cc_api_call_setup_ind_common:

cisco-username=30110

----- ccCallInfo IE subfields -----

cisco-ani=sip:30110@172.20.5.22

cisco-anitype=0

cisco-aniplan=0

cisco-anipi=0

cisco-anisi=0

dest=sip:5555@172.20.5.30:5060

cisco-desttype=0

cisco-destplan=0

cisco-rdie=FFFFFFFF

cisco-rdn=

cisco-rdntype=0

cisco-rdnplan=0

cisco-rdnpi=-1

cisco-rdnsi=-1

cisco-redirectreason=-1 fwd_final_type =0

final_redirectNumber =

hunt_group_timeout =0

*Feb 25 20:46:54.475: //-1/76B695000000/CCAPI/cc_api_call_setup_ind_common:

Interface=0x682705C8, Call Info(

Calling Number=sip:30110@172.20.5.22,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=sip:5555@172.20.5.30:5060(TON=Unknown, NPI=Unknown),

Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,

Incoming Dial-peer=5555, Progress Indication=NULL(0), Calling IE Present=TRUE,

Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=207

*Feb 25 20:46:54.475: //-1/76B695000000/CCAPI/ccCheckClipClir:

In: Calling Number=sip:30110@172.20.5.22(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

*Feb 25 20:46:54.475: //-1/76B695000000/CCAPI/ccCheckClipClir:

Out: Calling Number=sip:30110@172.20.5.22(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

*Feb 25 20:46:54.475: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Feb 25 20:46:54.475: :cc_get_feature_vsa malloc success

*Feb 25 20:46:54.475: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Feb 25 20:46:54.475: cc_get_feature_vsa count is 1

*Feb 25 20:46:54.475: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Feb 25 20:46:54.475: :FEATURE_VSA attributes are: feature_name:0,feature_time:1768577616,feature_id:97

*Feb 25 20:46:54.475: //207/76B695000000/CCAPI/cc_api_call_setup_ind_common:

Set Up Event Sent;

Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=(TON=Unknown, NPI=Unknown))

*Feb 25 20:46:54.479: //207/76B695000000/CCAPI/cc_process_call_setup_ind:

Event=0x68780750

*Feb 25 20:46:54.479: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:

Try with the demoted called number 5555

*Feb 25 20:46:54.479: //-1//SERV:/AFW_Service_CCInterface: Received Event 26 for service test modulehandle NULL

*Feb 25 20:46:54.479: //-1//SERV:/AFW_Service_GetExecEnv: Script Name = test

*Feb 25 20:46:54.479: //-1//AFW_:/AFW_Process_New: test

*Feb 25 20:46:54.483: //-1//SERV:/AFW_Service_GetExecEnv: Using Cached ExecEnv

*Feb 25 20:46:54.483: //-1//AFW_:EE6A392D60000:/AFW_ExecEnv_SetRoot: Execenv = 0x6A392D60

*Feb 25 20:46:54.483: //-1//AFW_:/AFW_M_TclModule_NewDup:

*Feb 25 20:46:54.483: //-1//AFW_:HN2D887F84:/AFW_M_TclModule_Free: MOD[TclModule_6A39E3D8_0_763740224] ( )

*Feb 25 20:46:54.483: //-1//AFW_:/AFW_M_FSM_Free:

*Feb 25 20:46:54.483: //-1//AFW_:/AFW_Process_Lock: pProcess(0x69681700)=1

*Feb 25 20:46:54.483: //-1//AFW_:LP:EE6A392D60000:HN2D967E88:/AFW_M_Object_SetExecEnv: ObjCount: 1, CmdPending 0

*Feb 25 20:46:54.483: //-1//AFW_:EE6A392D60000:/AFW_ExecEnv_RestoreDataBackup: Restore DataArea from Script

*Feb 25 20:46:54.487: //-1//AFW_:EE6A392D60000:/AFW_ExecEnv_RestoreDataBackup: Restore TokenTable from Script

*Feb 25 20:46:54.487: //-1//AFW_:EE6A392D60000:/AFW_ExecEnv_Initiate: Execenv = 0x6A392D60

*Feb 25 20:46:54.487: //-1//AFW_:EE6A392D60000:/AFW_ExecEnv_SetCallCorID:

*Feb 25 20:46:54.487: CallCorID is v6

*Feb 25 20:46:54.487: //-1//AFW_:/AFW_Leg_New:

*Feb 25 20:46:54.487: //207/76B695000000/CCAPI/ccCallSetContext:

Context=0x697CA32C

*Feb 25 20:46:54.487: //207//AFW_:/AFW_M_Leg_SetExecEnv:

*Feb 25 20:46:54.487: //-1//AFW_:EE6A392D60000:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 1

*Feb 25 20:46:54.487: //-1//AFW_:LP:EE6A392D60000:LG207:/AFW_M_Object_SetExecEnv: ObjCount: 2, CmdPending 1

*Feb 25 20:46:54.487: //207//AFW_:/AFW_Object_AddListener: adding Module TclModule as listener

*Feb 25 20:46:54.487: //207//AFW_:/AFW_M_Leg_GetHandle: Leg handle: LEG_207

*Feb 25 20:46:54.487: //-1//AFW_:EE6A392D60000:/AFW_ExecEnv_AssignCall: Execenv = 0x6A392D60, Leg = 207, Peer_Tag = 5555

*Feb 25 20:46:54.487: //207//AFW_:/AFW_ExecEnv_SetCallCorID:

*Feb 25 20:46:54.487: CallCorID is v6

*Feb 25 20:46:54.487: //207/76B695000000/CCAPI/cc_process_call_setup_ind:

>>>>CCAPI handed cid 207 with tag 5555 to app "_ManagedAppProcess_test"

*Feb 25 20:46:54.487: //-1//SERV:/AFW_Service_Process_Space:

*Feb 25 20:46:54.487: Process Started

*Feb 25 20:46:54.487: //-1//AFW_:/AFW_Process_Register: ccAppInitialize(name: _ManagedAppProcess_test)

*Feb 25 20:46:54.491: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 25 20:46:54.491: //207//AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 25 20:46:54.491: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_SETUP_IND(34)] {

*Feb 25 20:46:54.491: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x6A392D60][test]

*Feb 25 20:46:54.491: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[207][LEG_INIT(0)][Cause(0)]

*Feb 25 20:46:54.491: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 25 20:46:54.491: //207//SSIN:/AFW_SS_MapEvent:

*Feb 25 20:46:54.491: //-1//SSIN:/AFW_SS_SIP_MapEvent:

*Feb 25 20:46:54.491: //207/76B695000000/AFW_:/AFW_Leg_UpdateStats: Updating stats for ID 6C type 0

*Feb 25 20:46:54.495: //207/76B695000000/AFW_:/incrementIncomingDialPeerCallStats: Incrementing call-stat to [1] for dial-peer [5555]

*Feb 25 20:46:54.495: //207/76B695000000/AFW_:/AFW_Object_WalkListeners:

*Feb 25 20:46:54.495: //207/76B695000000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 25 20:46:54.495: //-1//AFW_:/AFW_M_Object_ShowListeners:

*Feb 25 20:46:54.495: //207//AFW_:/AFW_M_Module_GetHandle: Module handle: TclModule_682ADEDC_0_764837512MOD[TclModule_682ADEDC_0_764837512] (

*Feb 25 20:46:54.495: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[207][LEG_INCINIT(1)][Cause(0)]

*Feb 25 20:46:54.495: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 25 20:46:54.495: //207/76B695000000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 25 20:46:54.495: //207/76B695000000/AFW_:/AFW_Object_WalkListeners: Entering Module : TclModule

*Feb 25 20:46:54.495: //207//AFW_:/AFW_ExecEnv_SetModuleScope: TclModule_682ADEDC_0_764837512 ---> TclModule_682ADEDC_0_764837512

*Feb 25 20:46:54.495: //207//AFW_:/AFW_M_TclModule_Action:

*Feb 25 20:46:54.495: //207//AFW_:/AFW_TclModule_DefaultEvHandling:

*Feb 25 20:46:54.495: //207/76B695000000/AFW_:/AFW_Leg_CheckIncomingCallBlock:

*Feb 25 20:46:54.495: //207/76B695000000/AFW_:/AFW_Leg_SettlementValidateCall: target=, tokenp=0x0

*Feb 25 20:46:54.495: //207/76B695000000/AFW_:/AFW_Leg_IncomingTranslate:

*Feb 25 20:46:54.495: //-1//AFW_:/AFW_Leg_IncomingTranslate: Tag(5555) calling[30110] redirect[] called[5555]

*Feb 25 20:46:54.495: //207//AFW_:/AFW_FSM_Drive: ACTION BEGIN: ------(CALL_INIT[1],ev_setup_indication[34])---[act_Setup]------

*Feb 25 20:46:54.495: //207//TCL :/tcl_PutsObjCmd: proc act_Setup

*Feb 25 20:46:54.495:

*Feb 25 20:46:54.495: //207//TCL :/tcl_PutsObjCmd:

proc init_perCallvars

*Feb 25 20:46:54.495:

*Feb 25 20:46:54.499: //207//TCL :/tcl_InfotagObjCmd: infotag get leg_ani

*Feb 25 20:46:54.499: //207//TCL :/tcl_InfotagGetObjCmd: infotag get leg_ani

*Feb 25 20:46:54.499: //207//AFW_:/vtr_lg_ani: argc 2 argindex 2

*Feb 25 20:46:54.499: //207//TCL :/tcl_PutsObjCmd:

ANI sip:30110@172.20.5.22

*Feb 25 20:46:54.499:

*Feb 25 20:46:54.499: //207//TCL :/tcl_InfotagObjCmd: infotag get leg_dnis

*Feb 25 20:46:54.499: //207//TCL :/tcl_InfotagGetObjCmd: infotag get leg_dnis

*Feb 25 20:46:54.499: //207//AFW_:/vtr_lg_dnis: argc 2 argindex 2

*Feb 25 20:46:54.499: //207//TCL :/tcl_PutsObjCmd:

DNIS sip:5555@172.20.5.30:5060

*Feb 25 20:46:54.499:

*Feb 25 20:46:54.499: //207//TCL :/tcl_InfotagObjCmd: infotag set med_language 1

*Feb 25 20:46:54.499: //207//TCL :/tcl_InfotagSetObjCmd: infotag set med_language 1

*Feb 25 20:46:54.499: //207//AFW_:/vtw_ms_language: argc 3 argindex 2

*Feb 25 20:46:54.499: //207//TCL :/tcl_LegObjCmd: leg setupack leg_incoming

*Feb 25 20:46:54.499: //207//TCL :/tcl_LegSetupAckObjCmd: setupack leg_incoming

*Feb 25 20:46:54.499: //207//AFW_:/vtd_lg_incoming: argc 2

*Feb 25 20:46:54.499: //207//AFW_:/vtd_lg_incoming: Legs [207 ]

*Feb 25 20:46:54.499: //207//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1

*Feb 25 20:46:54.499: //207/76B695000000/CCAPI/ccCallSetupAck:

Call Id=207

*Feb 25 20:46:54.503: //207/76B695000000/CCAPI/cc_api_set_transfer_info:

Transfer Number=, Transfer Reason=0x0

*Feb 25 20:46:54.503: //207//TCL :/tcl_LegObjCmd: leg setup sip:5555@172.20.5.30:5060 callInfo leg_incoming

*Feb 25 20:46:54.503: //207//CSPK:/tcl_LegSetupObjCmd: leg setup sip:5555@172.20.5.30:5060 callInfo leg_incoming

*Feb 25 20:46:54.503: //207//AFW_:/vtd_lg_incoming: argc 4

*Feb 25 20:46:54.503: //207//AFW_:/vtd_lg_incoming: Legs [207 ]

*Feb 25 20:46:54.503: //207//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1

*Feb 25 20:46:54.503: //-1//AFW_:/AFW_Util_CopyCallDataToCallInfo: copied

*Feb 25 20:46:54.503: //-1/xxxxxxxxxxxx/CCAPI/ccGetMemPoolFromContainer:

mempool not found from usrContainer(69491D2C)

*Feb 25 20:46:54.503: //-1/xxxxxxxxxxxx/CCAPI/ccCreateMemPoolInContainer:

Mempool(6A33B728) created in usrContainer(69491D2C)

*Feb 25 20:46:54.503: //-1//AFW_:/AFW_Util_GetUsrContainerData: Container is present, No data

*Feb 25 20:46:54.503: //-1//AFW_:/AFW_Util_CopyCallDataToCallInfo: Successful in setting 'CC_TAG_SETUP_REQ_DATA' in usrContainer(69491D2C)

*Feb 25 20:46:54.503: ccDumpTdRequestDataGen:

*Feb 25 20:46:54.503: called_urip=NULL

*Feb 25 20:46:54.503: calling_urip=sip:30110@172.20.5.22

*Feb 25 20:46:54.503: url_dump_header_line_avpair:

*Feb 25 20:46:54.503: num_bodies = 0

*Feb 25 20:46:54.503: //-1//AFW_:/AFW_Util_CopyLegServiceCodeToCallInfoContainer: Service Code not available on Leg

*Feb 25 20:46:54.503: //-1//AFW_:/AFW_Util_CopyLegRouteCodeToCallInfoContainer: Route Code not available on Leg

*Feb 25 20:46:54.503: //-1//AFW_:/AFW_Util_GetTgCicValue: CIC Not found for tag(56)

*Feb 25 20:46:54.507: //-1//CSPK:/tclSetControlParams: alertTime(30) = 30

*Feb 25 20:46:54.507: //207//CSPK:/C_CallSetup_Start: ControlInfo = 0x6A3AD338, callInfo = 0x6A3C1658, destination[0]=sip:5555@172.20.5.30:5060

*Feb 25 20:46:54.507: //207//CSPK:/C_CallSetup_Start: configured mode=rotary (1)

*Feb 25 20:46:54.507: //207//CSPK:/C_CallSetup_Start: configured reroutemode=rotary (1)

*Feb 25 20:46:54.507: //-1//Call:/AFW_CallSetup_New:

*Feb 25 20:46:54.507: //-1//AFW_:/AFW_FSM_New:

*Feb 25 20:46:54.507: //-1//AFW_:LP:EE6A392D60000:HN2D967EA0:/AFW_M_Object_SetExecEnv: ObjCount: 3, CmdPending 1

*Feb 25 20:46:54.507: //207//AFW_:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 2

*Feb 25 20:46:54.507: //207//AFW_:/AFW_Object_AddListener: adding Module TclModule as listener

*Feb 25 20:46:54.507: //207//AFW_:/AFW_M_Module_GetHandle: Module handle: CallSetup_698003EC_0_764837536

*Feb 25 20:46:54.507: //207//Call:/AFW_CallSetup_AddDest: sip:5555@172.20.5.30:5060 index 0

*Feb 25 20:46:54.507: //207//Call:/AFW_CallSetup_SetIntWrkLeg:

*Feb 25 20:46:54.507: //207/76B695000000/AFW_:/AFW_Leg_SignalPeerGet: Leg [207]

*Feb 25 20:46:54.507: //-1//AFW_:/C_PackageSession_GetSigPeer:

*Feb 25 20:46:54.507: //207/76B695000000/AFW_:/C_PackageSession_GetSigPeer: No Interworking module on Leg, no signal peer

*Feb 25 20:46:54.511: //207//Call:/AFW_M_CallSetup_Initiate:

*Feb 25 20:46:54.511: //207/76B695000000/AFW_:/AFW_Leg_SetMLPPInfo: Unable to set mlpp info

*Feb 25 20:46:54.511: //-1//AFW_:/AFW_Util_CopyMLPPDataToCallInfoContainer: Voice MLPP not configured

*Feb 25 20:46:54.511: //207//Call:/CS_UpdateMLPPInfo: ServiceDomain:[none (0)] DomainIdentifier:[000000] PrecedenceLevel:[-1 (PRECEDENCE_LEVEL_NONE)] NormalizedPrecedence:[0 (INTERNAL_PRECEDENCE_0)] Preempt Hunt Not Set

*Feb 25 20:46:54.511: //207//Call:/CallSetupInitiate:

*Feb 25 20:46:54.511: //207//Call:/CS_Placecall:

*Feb 25 20:46:54.511: //207//Call:/setupHuntGroupInfo: hunt group destination has to be E.164 number

*Feb 25 20:46:54.511: //207/76B695000000/AFW_:/AFW_Leg_SetMLPPInfo: Unable to set mlpp info

*Feb 25 20:46:54.511: //-1//AFW_:/AFW_Util_CopyMLPPDataToCallInfoContainer: Voice MLPP not configured

*Feb 25 20:46:54.511: //-1//Dest:/AFW_Destination_New:

*Feb 25 20:46:54.511: //-1//AFW_:/AFW_FSM_New:

*Feb 25 20:46:54.511: //-1//AFW_:LP:EE6A392D60000:HN2D967EA4:/AFW_M_Object_SetExecEnv: ObjCount: 4, CmdPending 2

*Feb 25 20:46:54.511: //207//AFW_:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 3

*Feb 25 20:46:54.511: //207//AFW_:/AFW_Object_AddListener: adding Module CallSetup as listener

*Feb 25 20:46:54.511: //207//AFW_:/AFW_M_Module_GetHandle: Module handle: Destination_698326C4_0_764837540

*Feb 25 20:46:54.511: //207//Dest:/AFW_Destination_AddDest:

*Feb 25 20:46:54.511: //-1//Dest:/AFW_Destination_AddDest: adding destination "sip:5555@172.20.5.30:5060"

*Feb 25 20:46:54.515: //207//Dest:/AFW_Destination_SetIntWrkLeg: LEG[207 ][LEG_INCACKED(2)][Cause(0)]

*Feb 25 20:46:54.515: //207//Dest:/TermInterworking: current state IW_STATE_INIT, Keep IntWrkLeg

*Feb 25 20:46:54.515: //207//Dest:/DestSetIntWrkLeg:

*Feb 25 20:46:54.515: //207/76B695000000/AFW_:/AFW_Object_AddListener: adding Module Destination as listener

*Feb 25 20:46:54.515: //207//Dest:/AFW_M_Destination_Initiate:

*Feb 25 20:46:54.515: //-1//AFW_:/AFW_Util_SaveRawMsg:

*Feb 25 20:46:54.515: //207//Dest:/AFW_M_Destination_Initiate: Outgoing guid : 76B69500.00010000.00000045.160514AC

*Feb 25 20:46:54.515: Incoming_guid : 00000000.00000000.00000000.00000000

*Feb 25 20:46:54.515: //207//Dest:/AFW_M_Destination_Initiate: Outgoing gcid : BCF7DB89.DB3711E5.81958EDD.70D74969

*Feb 25 20:46:54.515: Incoming_gcid : 00000000.00000000.00000000.00000000

*Feb 25 20:46:54.515: //207/76B695000000/AFW_:/AFW_Leg_SetMLPPInfo: Unable to set mlpp info

*Feb 25 20:46:54.515: //-1//AFW_:/AFW_Util_CopyMLPPDataToCallInfoContainer: Voice MLPP not configured

*Feb 25 20:46:54.515: //207//Dest:/DestUpdateMLPPInfo: ServiceDomain:[none (0)] DomainIdentifier:[000000] PrecedenceLevel:[-1 (PRECEDENCE_LEVEL_NONE)] NormalizedPrecedence:[-1 (PRECEDENCE_LEVEL_NONE)] Preempt Hunt Not Set

*Feb 25 20:46:54.515: //207//Dest:/DestSetupInitiate:

*Feb 25 20:46:54.515: //207/76B695000000/SSIN:/AFW_SS_SIP_CheckConsultSetup:

*Feb 25 20:46:54.515: //207//Dest:/DestAddRerouteSetupInfo:

*Feb 25 20:46:54.515: //207//Dest:/DestAddTransferSetupInfo:

*Feb 25 20:46:54.515: //-1//AFW_:/AFW_Util_CopyCallDataToCallInfo: copied sip:5555@172.20.5.30:5060

*Feb 25 20:46:54.515: //-1//AFW_:/AFW_Util_CopyCallDataToCallInfo: Successful in setting 'CC_TAG_SETUP_REQ_DATA' in usrContainer(69491D2C)

*Feb 25 20:46:54.515: ccDumpTdRequestDataGen:

*Feb 25 20:46:54.515: called_urip=sip:5555@172.20.5.30:5060

*Feb 25 20:46:54.515: calling_urip=sip:30110@172.20.5.22

*Feb 25 20:46:54.515: url_dump_header_line_avpair:

*Feb 25 20:46:54.515: num_bodies = 0

*Feb 25 20:46:54.515: //207//Dest:/DestMatchDialPeer:

*Feb 25 20:46:54.519: //207//Dest:/DestMatchDialPeer: src carrier id:, tgt carrier id:

*Feb 25 20:46:54.519: //207//Dest:/DestSetupInitiate: Did not match any peers

*Feb 25 20:46:54.519: //207//Dest:/DestResetCallInfo:

*Feb 25 20:46:54.519: //207//Dest:/DestComplete: peer #:0 IW State IW_STATE_INIT, OB State OB_STATE_INIT

*Feb 25 20:46:54.519: //-1//Dest:/DestStatusFromDiscCause: mapped "unassigned number (1)"(1) to DEST_INVALID_NUMBER(4)

*Feb 25 20:46:54.519: //-1//AFW_:/AFW_Event_New: Event ID: ev_destination_done

*Feb 25 20:46:54.519: //207//AFW_:/AFW_Module_ReturnArgEv:

*Feb 25 20:46:54.519: //207//AFW_:/AFW_Module_ReturnArgEv: Return List (remove=TRUE){LEG[207 ][LEG_INCACKED(2)][Cause(0)]}

*Feb 25 20:46:54.519: //207/76B695000000/AFW_:/AFW_Object_RemoveListener:

*Feb 25 20:46:54.519: //207//AFW_:/AFW_Module_UnListen: NumObjects: 0

*Feb 25 20:46:54.519: //207//Dest:/DestReturn: Destination Returning(ds_004 Status DEST_INVALID_NUMBER)

*Feb 25 20:46:54.519: //207//Call:/CS_Placecall: Call placed to sip:5555@172.20.5.30:5060 index 0

*Feb 25 20:46:54.519: //207//TCL :/tcl_FSMObjCmd: fsm setstate HANDOFF

*Feb 25 20:46:54.519: //207//TCL :/tcl_FSMSetStateObjCmd: setstate setstate HANDOFF

*Feb 25 20:46:54.519: //207//AFW_:/AFW_FSM_Drive: ACTION END: -------------(HANDOFF[4])---------------

*Feb 25 20:46:54.519: //207//AFW_:/AFW_ExecEnv_SetModuleScope: TclModule_682ADEDC_0_764837512 ---> TclModule_682ADEDC_0_764837512

*Feb 25 20:46:54.523: //207/76B695000000/AFW_:/AFW_M_Event_Free:

*Feb 25 20:46:54.523: //207//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 3

*Feb 25 20:46:54.523: //207//AFW_:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED

*Feb 25 20:46:54.523: //207//AFW_:/AFW_Process_GetPriorityQEvent: Received

*Feb 25 20:46:54.523: //-1//AFW_:/AFW_Process_GetPriorityQEvent: Event[APP_EV_DESTINATION_DONE(221)] {

*Feb 25 20:46:54.523: //-1//AFW_:/AFW_Process_GetPriorityQEvent: EXECENV[0x6A392D60][test]

*Feb 25 20:46:54.523: //-1//AFW_:/AFW_Process_GetPriorityQEvent: MOD[Destination_698326C4_0_764837540] (

*Feb 25 20:46:54.523: //-1//AFW_:/AFW_Process_GetPriorityQEvent: )

*Feb 25 20:46:54.523: //-1//AFW_:/AFW_Process_GetPriorityQEvent: }

*Feb 25 20:46:54.523: //207//Dest:/AFW_M_Destination_EventPreProcess:

*Feb 25 20:46:54.523: //207//AFW_:/AFW_Object_WalkListeners:

*Feb 25 20:46:54.523: //207//AFW_:/AFW_M_Object_ShowListeners: START

*Feb 25 20:46:54.523: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[CallSetup_698003EC_0_764837536] (

*Feb 25 20:46:54.523: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_698326C4_0_764837540] (

*Feb 25 20:46:54.523: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 25 20:46:54.523: //207//AFW_:/AFW_M_Object_ShowListeners: END

*Feb 25 20:46:54.523: //207//AFW_:/AFW_Object_WalkListeners: Entering Module : CallSetup

*Feb 25 20:46:54.523: //207/76B695000000/AFW_:/AFW_Object_AddListener: adding Module CallSetup as listener

*Feb 25 20:46:54.523: //207//AFW_:/AFW_Object_RemoveListener:

*Feb 25 20:46:54.523: //207//AFW_:/AFW_Module_UnListen: NumObjects: 1

*Feb 25 20:46:54.527: //207//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> CallSetup_698003EC_0_764837536

*Feb 25 20:46:54.527: //207//Call:/AFW_M_CallSetup_Action:

*Feb 25 20:46:54.527: //207//AFW_:/AFW_FSM_Drive: ACTION BEGIN: ------(S_PLACECALL[2],ev_destination_done[221])---[C_Action]------

*Feb 25 20:46:54.527: //207//Call:/CS_Placecall_DestDone:

*Feb 25 20:46:54.527: //207//AFW_:/AFW_FSM_Drive: ACTION END: -------------(S_DONE[13])---------------

*Feb 25 20:46:54.527: //-1//AFW_:/AFW_Event_New: Event ID: ev_setup_done

*Feb 25 20:46:54.527: //207//AFW_:/AFW_Module_ReturnArgEv:

*Feb 25 20:46:54.527: //207//AFW_:/AFW_Module_ReturnArgEv: Return List (remove=TRUE){LEG[207 ][LEG_INCACKED(2)][Cause(0)]}

*Feb 25 20:46:54.527: //207/76B695000000/AFW_:/AFW_Object_RemoveListener:

*Feb 25 20:46:54.527: //207//AFW_:/AFW_Module_UnListen: NumObjects: 0

*Feb 25 20:46:54.527: //207//Call:/CS_Complete: CallSetup Returning(ls_004 Status CS_INVALID_NUMBER)

*Feb 25 20:46:54.527: //207//AFW_:/AFW_ExecEnv_SetModuleScope: CallSetup_698003EC_0_764837536 ---> NULL

*Feb 25 20:46:54.527: //207//AFW_:/AFW_Object_WalkListeners:

*Feb 25 20:46:54.527: //207//AFW_:/AFW_M_Object_ShowListeners: START

*Feb 25 20:46:54.527: //207//AFW_:/AFW_M_Object_ShowListeners: END

*Feb 25 20:46:54.527: //207//AFW_:/AFW_M_Event_Free:

*Feb 25 20:46:54.527: //207//AFW_:/AFW_M_Event_Free: MODULEDONEEVENT for a Module: Destination_698326C4_0_764837540

*Feb 25 20:46:54.527: //207//AFW_:/AFW_Object_RemoveAllListener:

*Feb 25 20:46:54.527: //-1//AFW_:/AFW_M_Object_UnSetExecEnv: ObjCount: 3, CmdPending 3

*Feb 25 20:46:54.527: //207//AFW_:/AFW_ExecEnv_DecrNPendingCmd: PendingCmdCount: 2

*Feb 25 20:46:54.527: //-1//AFW_:HN2D967EA4:/AFW_M_Event_Free: ExecEnv objCount: 3

*Feb 25 20:46:54.527: //-1//Dest:HN2D967EA4:/AFW_M_Destination_Free:

*Feb 25 20:46:54.527: //-1//Dest:HN2D967EA4:/DestEmptyPreemptHoldQ:

*Feb 25 20:46:54.527: //-1//AFW_:/AFW_M_FSM_Free:

*Feb 25 20:46:54.531: //207//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 2

*Feb 25 20:46:54.531: //207//AFW_:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED

*Feb 25 20:46:54.531: //207//AFW_:/AFW_Process_GetPriorityQEvent: Received

*Feb 25 20:46:54.531: //-1//AFW_:/AFW_Process_GetPriorityQEvent: Event[APP_EV_CALLSETUP_DONE(219)] {

*Feb 25 20:46:54.531: //-1//AFW_:/AFW_Process_GetPriorityQEvent: EXECENV[0x6A392D60][test]

*Feb 25 20:46:54.531: //-1//AFW_:/AFW_Process_GetPriorityQEvent: MOD[CallSetup_698003EC_0_764837536] (

*Feb 25 20:46:54.531: //-1//AFW_:/AFW_Process_GetPriorityQEvent: )

*Feb 25 20:46:54.531: //-1//AFW_:/AFW_Process_GetPriorityQEvent: }

*Feb 25 20:46:54.531: //207//Call:/AFW_M_CallSetup_EventPreProcess:

*Feb 25 20:46:54.531: //207//AFW_:/AFW_Object_WalkListeners:

*Feb 25 20:46:54.531: //207//AFW_:/AFW_M_Object_ShowListeners: START

*Feb 25 20:46:54.531: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_682ADEDC_0_764837512] (

*Feb 25 20:46:54.531: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[207][LEG_INCACKED(2)][Cause(0)]

*Feb 25 20:46:54.531: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[CallSetup_698003EC_0_764837536] (

*Feb 25 20:46:54.531: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 25 20:46:54.531: //207//AFW_:/AFW_M_Object_ShowListeners: END

*Feb 25 20:46:54.531: //207//AFW_:/AFW_Object_WalkListeners: Entering Module : TclModule

*Feb 25 20:46:54.531: //207/76B695000000/AFW_:/AFW_Object_AddListener: adding Module TclModule as listener

*Feb 25 20:46:54.535: //207//AFW_:/AFW_Object_RemoveListener:

*Feb 25 20:46:54.535: //207//AFW_:/AFW_Module_UnListen: NumObjects: 1

*Feb 25 20:46:54.535: //207//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> TclModule_682ADEDC_0_764837512

*Feb 25 20:46:54.535: //207//AFW_:/AFW_M_TclModule_Action:

*Feb 25 20:46:54.535: //207//AFW_:/AFW_TclModule_DefaultEvHandling:

*Feb 25 20:46:54.535: //207//AFW_:/AFW_TclModule_UpdateSessionMask: Update intwrk-mask for leg [207]'s session

*Feb 25 20:46:54.535: //207//AFW_:/AFW_FSM_Drive: ACTION BEGIN: ------(HANDOFF[4],ev_setup_done[219])---[act_CallSetupDone]------

*Feb 25 20:46:54.535: //207//TCL :/tcl_InfotagObjCmd: infotag get evt_status

*Feb 25 20:46:54.535: //207//TCL :/tcl_InfotagGetObjCmd: infotag get evt_status

*Feb 25 20:46:54.535: //207//AFW_:/vtr_ev_status: argc 2 argindex 2

*Feb 25 20:46:54.535: //207//TCL :/tcl_PutsObjCmd:

Call failed. Play prompt and collect digit

*Feb 25 20:46:54.535:

*Feb 25 20:46:54.535: //207//TCL :/tcl_PutsObjCmd:

proc act_Select

*Feb 25 20:46:54.535:

*Feb 25 20:46:54.535: //207//TCL :/tcl_LegObjCmd: leg collectdigits leg_incoming param1

*Feb 25 20:46:54.535: //207//Digi:/tcl_LegDigitCollectObjCmd: collectdigits leg_incoming param1

*Feb 25 20:46:54.535: //207//AFW_:/vtd_lg_incoming: argc 3

*Feb 25 20:46:54.535: //207//AFW_:/vtd_lg_incoming: Legs [207 ]

*Feb 25 20:46:54.539: //207//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1

*Feb 25 20:46:54.539: //207//Digi:/C_DigitCollect_Start: Leg=207, Dialplan=True, Diaplanterm=True, DigitReport=False, DigitConsume=False IgnoreInitialKey=False, IgnoreDTMFacceptINFO=False, Abortkey=*, Terminationkey=#, Numpatterns=0, Maxdigits=0, Mindigits=0, Interruptprompt=True, InterTimeout=-1000, Initialtimeout=-1000, Mask=0 Hotword=0

*Feb 25 20:46:54.539: //-1//Digi:/AFW_DigitCollect_New:

*Feb 25 20:46:54.539: //-1//Digi:HN2D967EC0:/AFW_DigitCollect_New: DialPlan=TRUE AbortKey=* TermKey=# NumPatts=0

Enable=FALSE Consume=FALSE InterruptPrompt=TRUE minDigits=0 maxDigits=0 DialPlanTerm=TRUE hotword=0

*Feb 25 20:46:54.539: //-1//AFW_:LP:EE6A392D60000:HN2D967EC0:/AFW_M_Object_SetExecEnv: ObjCount: 4, CmdPending 2

*Feb 25 20:46:54.539: //207//AFW_:/AFW_Object_AddListener: adding Module TclModule as listener

*Feb 25 20:46:54.539: //207//AFW_:/AFW_M_Module_GetHandle: Module handle: DigitCollect_6A37B624_0_764837568

*Feb 25 20:46:54.539: //207/76B695000000/AFW_:/AFW_Object_AddListener: adding Module DigitCollect as listener

*Feb 25 20:46:54.539: //207/76B695000000/Digi:/DigitCollectStart_UpdateStats:

*Feb 25 20:46:54.539: //207//Digi:/DigitCollect_MLPPTuning:

*Feb 25 20:46:54.539: //207/76B695000000/AFW_:/AFW_Leg_PrecedenceDcValid:

*Feb 25 20:46:54.539: //207//Digi:/DigitCollect_MLPPTuning: Precednece Digit Collect not enabled

*Feb 25 20:46:54.539: //207/76B695000000/AFW_:/AFW_Leg_TypeAheadGet: no chars in buffer.

*Feb 25 20:46:54.539: //207/76B695000000/CCAPI/ccSetDigitTimeouts:

Initial Digit Timeout=-1000(ms), Inter Digit Timeout=-1000(ms)

*Feb 25 20:46:54.539: //207/76B695000000/CCAPI/ccSetDigitTimeouts:

Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=10000(ms))

*Feb 25 20:46:54.539: //207/76B695000000/AFW_:/AFW_Leg_DigitReportEnable: Current: 0x0 Input: 0x2

*Feb 25 20:46:54.539: //207/76B695000000/CCAPI/ccCallReportDigits:

(callID=0xCF, digit_event=0x1, enable=TRUE, consume=FALSE)

*Feb 25 20:46:54.539: //207/76B695000000/CCAPI/ccCallReportDigits:

Enabled=TRUE, Call Id=207

*Feb 25 20:46:54.543: //207//TCL :/tcl_PutsObjCmd:

proc act_DestBusy

*Feb 25 20:46:54.543:

*Feb 25 20:46:54.543: //207//PACK:/tcl_MediaObjCmd: media play leg_incoming _disconnect.au

*Feb 25 20:46:54.543: //207//PACK:/tcl_MediaPlayObjCmd: play leg_incoming _disconnect.au

*Feb 25 20:46:54.543: //207//AFW_:/vtd_lg_incoming: argc 3

*Feb 25 20:46:54.543: //207//AFW_:/vtd_lg_incoming: Legs [207 ]

*Feb 25 20:46:54.543: //207//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1

*Feb 25 20:46:54.543: //-1//DPM :DP86:/pc_mc_addToDynamicS: (1) _disconnect.au

*Feb 25 20:46:54.543: //-1//DPM :DP86:/pc_mc_addToDynamicS: Doing : _disconnect.au

*Feb 25 20:46:54.543: //-1//DPM :/mcTokenizerGetNext: savedcharptr=_ endptrptr=_disconnect.au

*Feb 25 20:46:54.543: //-1//DPM :DP86:/pc_mc_addToDynamicS: Token : _disconnect.au status 1

*Feb 25 20:46:54.543: //-1//DPM :DP86:/pc_mc_addToDynamicS: call dp_mcDQfromFileDynamic() to Handle relative file name

*Feb 25 20:46:54.543: //-1//DPM :DP86:/dp_mcDQfromFileDynamic: pLanguage=en FileName=_disconnect.au

*Feb 25 20:46:54.543: //-1//DPM :DP86:/dp_mcDQfromURL: file=flash:en_disconnect.au

*Feb 25 20:46:54.543: //-1//MCM :/mc_createFromFileUrl: Getting a media content: name=en_disconnect.au

url=flash:en_disconnect.au

load fast, fetchtimeout=-1

*Feb 25 20:46:54.543: //-1//MCM :MC14:/mc_getFromUrlName: en_disconnect.au on ram

*Feb 25 20:46:54.543: //-1//MCM :/mc_createFromFileUrl: Found a good mc (0x6A3AF9A8), RefCount(1)

*Feb 25 20:46:54.543: //-1//DPM :DP86:/dp_mcDQfromURL: mc_createFromFileUrl OK

*Feb 25 20:46:54.543: //-1//DPM :/mcTokenizerGetNext: savedcharptr= endptrptr=

*Feb 25 20:46:54.543: //207//PACK:/Media_Play_Start:

*Feb 25 20:46:54.547: //-1//PACK:/Media_Play_Start: pLeg->stream is null, call msw_create()

*Feb 25 20:46:54.547: //207//MSW :/msw_create: cbf=0x62A841C0

*Feb 25 20:46:54.547: //-1//MSM :MS111:/ms_create: Iniz ply_timer

*Feb 25 20:46:54.547: //207//MSW :/msw_synth_open: mediaStream 0x6A333418 created

*Feb 25 20:46:54.547: //207//MSW :/msw_synth_open: rtspStream 0x6848A1EC created,

status=RTSP_STATUS_SUCCESS, session_id=0x6F (111)

*Feb 25 20:46:54.547: //207//MSW :/msw_synth_open: AIS : Creating TTS AIS Backend record

*Feb 25 20:46:54.547: //207//MRCP:/mrcp_create_session:

url=rtsp://tts-en-us/synthesizer, type=SYNTHESIZER, streamcontext=0x68489B54, sess_id=-1

*Feb 25 20:46:54.547: //207//MRCP:/mrcp_create_session:

New SCB creation

*Feb 25 20:46:54.547: //207//MRCP:/mrcp_add_synthesizer_fsm:

adding synthesizer fsm

*Feb 25 20:46:54.547: //207//MRCP:/mrcp_add_connection_fsm:

adding connection fsm

*Feb 25 20:46:54.547: //207//MRCP:/mrcp_add_connection_fsm:

adding connection (fsm) 6984C360

*Feb 25 20:46:54.547: //207//MRCP:/mrcp_add_rtpsetup_fsm:

adding rtpsetup fsm

*Feb 25 20:46:54.547: //207//MRCP:/mrcp_create_svr_session_url:

url=rtsp://tts-en-us/synthesizer

*Feb 25 20:46:54.547: //-1//MRCP:/hash_get:

Table=mrcp_host_stat_table, Key=12

*Feb 25 20:46:54.547: //-1//MSM :MS112:/ms_create: Iniz ply_timer

*Feb 25 20:46:54.547: //207//MSW :/msw_recrd_open:

*Feb 25 20:46:54.547: :msw_recrd_open mediaStream 0x69773964 created

*Feb 25 20:46:54.547: //207//MSW :/msw_recrd_open: rtspStream 0x6848A1F4 created,

status=RTSP_STATUS_SUCCESS, session_id=0x70 (112)

*Feb 25 20:46:54.547: //207//MSW :/msw_recog_open: AIS : Creating ASR AIS Backend record

*Feb 25 20:46:54.547: //207//MRCP:/mrcp_create_session:

url=rtsp://asr-en-us/recognizer, type=RECOGNIZER, streamcontext=0x68489C10, sess_id=57

*Feb 25 20:46:54.547: //207//MRCP:/mrcp_create_session:

Already an SCB is created for this call

*Feb 25 20:46:54.547: //207//MRCP:/mrcp_add_recognizer_fsm:

adding recognizer fsm

*Feb 25 20:46:54.547: //207//MRCP:/mrcp_add_connection_fsm:

adding connection fsm

*Feb 25 20:46:54.547: //207//MRCP:/mrcp_add_connection_fsm:

adding connection (fsm) 6A35AF84

*Feb 25 20:46:54.551: //207//MRCP:/mrcp_add_rtpsetup_fsm:

adding rtpsetup fsm

*Feb 25 20:46:54.551: //207//MRCP:/mrcp_create_svr_session_url:

url=rtsp://asr-en-us/recognizer

*Feb 25 20:46:54.551: //-1//MRCP:/hash_get:

Table=mrcp_host_stat_table, Key=41

*Feb 25 20:46:54.551: //-1//PACK:/Media_Play_Start: msw_create() succeed to create stream [56]

*Feb 25 20:46:54.551: //-1//MSW :/msw_associate_call:

*Feb 25 20:46:54.551: msw_associate_call: callID=0xCF(207),

genericStream=0x68489B50

*Feb 25 20:46:54.551: //207//MRCP:/mrcp_associate_call:

sess_id=57, type=SYNTHESIZER

*Feb 25 20:46:54.551: //207//MRCP:/mrcp_associate_call:

sess_id=57, type=RECOGNIZER

*Feb 25 20:46:54.551: //207//MSW :/msw_synth_get_stream_state: genericStream 0x68489B50 is in state MSW_S_IDLE

*Feb 25 20:46:54.551: //-1//MSW :/msw_synth_start:

*Feb 25 20:46:54.551: msw_synth_start: Enter...

*Feb 25 20:46:54.551: //207//MSW :/msw_synth_start: current_stream_id=1, content 0x0, dynamicS 0x6976D738, current_state=MSW_S_IDLE

*Feb 25 20:46:54.551: //-1//MSW :/msw_synth_start: msw_synth_start: p_mcDynamicS, We've been given a list of URLs to play.

*Feb 25 20:46:54.551: //-1//MSW :/msw_synth_start: p_mcDynamicQ is NOT empty

*Feb 25 20:46:54.551: //207//MSW :/msu_synth_partial_play: Media Stream URL

*Feb 25 20:46:54.551: //207/76B695000000/CCAPI/ccAssociateStream:

Coder=5, DTMF Relay=1, Vad=0,

Record Function=0x0, Event Queue=0x6876B948, Stream Context=6A333418,

Record Context=0x0, Stream Call Id=208, Call Id=207

*Feb 25 20:46:54.551: //207/76B695000000/CCAPI/ccAssociateStream:

Call Entry(Stream Status=2, Digit Enable=FALSE)

*Feb 25 20:46:54.551: //207//TCL :/tcl_FSMObjCmd: fsm setstate CALLDISCONNECT

*Feb 25 20:46:54.551: //207//TCL :/tcl_FSMSetStateObjCmd: setstate setstate CALLDISCONNECT

*Feb 25 20:46:54.551: //207//AFW_:/AFW_FSM_Drive: ACTION END: -------------(CALLDISCONNECT[2])

Re: TCL example its-CISCO issue

yawming — Thu, 25 Feb 2016 21:05:40 GMT

From the log you have, this may relate to the environment you have. Can you please briefly describe what you are trying to achieve ? Maybe we can find another script fit your application better.

Re: TCL example its-CISCO issue

jvazquez — Thu, 25 Feb 2016 21:18:54 GMT

From call manager dial in to GW script ( DN 5555 dia peer trough sip trunk) scripts answer ask for destination number to connect call trough PSTN or another extension on CM and connect them .

-- CM Ext 30110-- sip trunk DN 555 ---> GW--Tranfer to Destination number -- PSTN or another extension on CM

Thanks in advance

Re: TCL example its-CISCO issue

yawming — Thu, 25 Feb 2016 21:54:18 GMT

Here is the issue:

DNIS sip:5555@172.20.5.30:5060

After certain version of IOS, infortag (dnis [infotag get leg_dnis]) is not returning number only, it returns above.

Solution is to extract the number or use new command.

Pleas see the following post

New Tcl IVR command option for "infotag get leg_dnis" and "infotag get leg_ani"

Re: TCL example its-CISCO issue

jvazquez — Thu, 25 Feb 2016 22:55:01 GMT

You are totally right -- i mad call trough FXS or sccp .. and it works since it is no sip and for SIP also made transformation for dest 5555@xxxxxx to 5555 and it works

thanks

what tool do you suggest for recording new audio (prompts) to customize my self

Re: TCL example its-CISCO issue

yawming — Thu, 25 Feb 2016 23:19:46 GMT

Not following recording tool lately but any tool can record .wav or .au file should be fine. I would use G.711 format to be safe.

Re: TCL example its-CISCO issue

jvazquez — Fri, 26 Feb 2016 20:20:43 GMT

How do i modify length destination ??? always keep 5 set dest [infotag get evt_dcdigits] from this event here

*Feb 26 20:23:16.691: //65//TCL :/tcl_PutsObjCmd:

DESTLEN: 5

*Feb 26 20:23:16.691:

Re: TCL example its-CISCO issue

yawming — Fri, 26 Feb 2016 20:46:15 GMT

if [infotag get cfg_avpair_exists max-extension-length] {

set maxExtensionLen [string trim [infotag get cfg_avpair max-extension-length]]

if { $maxExtensionLen < 0 } {

call close

}

} else {

set maxExtensionLen 5

}

so you need to add "param max-extension-length ?" to the max digit length you want in the following

Default is 5

service test its-CISCO.tcl

paramspace english index 1

paramspace english lenguage en

paramspace english location flash:

param aa-pilot 5555

param operator 9998

Re: TCL example its-CISCO issue

jvazquez — Fri, 26 Feb 2016 22:01:49 GMT

I believe thats the extension witch im calling and the one for connect destination is different

global maxExtensionLen -- > this one i could modified to 13 with out problem param max-extension-length

global destExtLen -- this one is what i need to increase

MAXEXTENSION: 13

*Feb 26 22:10:41.615:

*Feb 26 22:10:41.615: //90//TCL :/tcl_InfotagObjCmd: infotag get evt_dcdigits

*Feb 26 22:10:41.615: //90//TCL :/tcl_InfotagGetObjCmd: infotag get evt_dcdigits

*Feb 26 22:10:41.615: //90//AFW_:/vtr_ev_dcdigits: argc 2

*Feb 26 22:10:41.615: //90//AFW_:/vtr_ev_dcdigits: DCDIGITS [33300]

*Feb 26 22:10:41.615: //90//TCL :/tcl_PutsObjCmd:

DESTLEN: 5

*Feb 26 22:10:41.615:

*Feb 26 22:10:41.615: //90//TCL :/tcl_PutsObjCmd:

extLength: 8

*Feb 26 22:10:41.615:

*Feb 26 22:10:41.615: //90//TCL :/tcl_PutsObjCmd:

DIGITS: 33300

so i enter when ask for destination 330038670 and cut it to the first 5 digits

proc act_GotDest { } {

global dest

global maxExtensionLen

global destExtLen

global callInfo

global oprtr

global busyPrompt

global pin

puts "\n proc act_GotDest"

set status [infotag get evt_status]

set callInfo(alertTime) 30

puts "\n STATUS: $status"

puts "\n MAXEXTENSION: $maxExtensionLen"

if { ($status == "cd_004") } {

set dest [infotag get evt_dcdigits]

set destExtLen [string length $dest]

puts "\n DESTLEN: $destExtLen"

set extLength [expr $maxExtensionLen - $destExtLen]

if { $dest == "0" } {

set dest $oprtr

}

puts "\n extLength: $extLength"

puts "\n DIGITS: $dest"

Re: TCL example its-CISCO issue

yawming — Fri, 26 Feb 2016 22:07:42 GMT

you may need to reload the service after adding new param

Re: TCL example its-CISCO issue

jvazquez — Fri, 26 Feb 2016 22:52:23 GMT

did that too but no work,

from my interpretation of code i don see relation between maxExtensionLen and destExtLen

as you mention maxExtensionLen is defined on parameter begin of code and i think is used for extension i am using to dial in to service but destExtLen gets digits from evt_dcdigits witch are digit that i enter when audio prompt is played but only takes first 5 .. any ideas ?

c act_GotDest { } {

global dest

global maxExtensionLen

global destExtLen

global callInfo

global oprtr

global busyPrompt

global pin

puts "\n proc act_GotDest"

set status [infotag get evt_status]

set callInfo(alertTime) 30

puts "\n STATUS: $status"

puts "\n MAXEXTENSION: $maxExtensionLen"

if { ($status == "cd_004") } {

set dest [infotag get evt_dcdigits]

set destExtLen [string length $dest]

Re: TCL example its-CISCO issue

yawming — Fri, 26 Feb 2016 23:11:59 GMT

Can you please attach debug ?

Re: TCL example its-CISCO issue

yawming — Fri, 26 Feb 2016 23:25:09 GMT

Ok,

	set param1(dialPlan) true
	leg collectdigits leg_incoming param1

dialPlan is set to true so check you IOS dial-plan

other way to do is like this:

set param1(interruptPrompt) true

set param1(maxDigits) $maxExtensionLen

set param1(initialDigitTimeout) 5

set param1(terminationKey) #

leg collectdigits leg_incoming param1

Re: TCL example its-CISCO issue

jvazquez — Sat, 27 Feb 2016 00:19:46 GMT

*Feb 27 00:27:45.870: //209/9DE891800000/CCAPI/cc_api_call_digit_begin:

Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=0,

Source Call Id=209, Digit=3, DigitBeginFlags=0x0,

Rtp Timestamp=0x0, Rtp Expiration=0x0

*Feb 27 00:27:45.870: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:45.870: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:45.870: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_BEGIN(19)] {

*Feb 27 00:27:45.870: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:45.874: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:45.874: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:45.874: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:45.874: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:45.874: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:46.010: //209/9DE891800000/CCAPI/cc_api_call_digit_end:

Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=0,

Source Call Id=209, Digit=3, Duration=160,

Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF

*Feb 27 00:27:46.010: //209/9DE891800000/CCAPI/cc_api_call_digit_end:

Call Entry(Handoff Depth=0)

*Feb 27 00:27:46.010: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:46.010: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:46.014: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_END(18)] {

*Feb 27 00:27:46.014: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:46.014: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:46.014: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:46.014: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:46.014: //209/9DE891800000/AFW_:/AFW_M_Leg_EventPreProcess: Passing, not enabled.---

*Feb 27 00:27:46.014: //-1//MSW :/msw_recrd_stop: genericStream=0x6847C1B8,

mediaStream=0x6A295288, rtspStream=0x6847CC44

reason=MSW_RECRD_REASON_INTERRUPTED current_state=MSW_S_IDLE

*Feb 27 00:27:46.014: //-1//MSW :/msw_recrd_stop: Stream not currently active

*Feb 27 00:27:46.014: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:27:46.014: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:27:46.014: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696D9DFC_0_73558152] (

*Feb 27 00:27:46.014: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:46.014: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:46.014: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:27:46.014: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:46.018: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696D9DFC_0_73558152] (

*Feb 27 00:27:46.018: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:46.018: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:46.018: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:27:46.018: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect

*Feb 27 00:27:46.018: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_696D9DFC_0_73558152

*Feb 27 00:27:46.018: //209//Digi:/AFW_M_DigitCollect_Action:

*Feb 27 00:27:46.018: //209//Digi:/act_DCRunning_Digit: : pLeg 209 Digit 3 Tone Mode 0

*Feb 27 00:27:46.018: //209//Digi:/DigitCollect_TreatDigit:

*Feb 27 00:27:46.018: //209//Digi:/DigitCollect_DialPlanMatch: pattern offset=0, digits=3333

*Feb 27 00:27:46.018: //209//Digi:/DigitCollect_DialPlanMatch: src carrier id:, tgt carrier id:

*Feb 27 00:27:46.018: //209//Digi:/DigitCollect_DialPlanMatch: Match single infotype

*Feb 27 00:27:46.018: //209//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_696D9DFC_0_73558152 ---> NULL

*Feb 27 00:27:46.018: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:46.022: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:47.130: //209/9DE891800000/CCAPI/cc_api_call_digit_begin:

Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=0,

Source Call Id=209, Digit=2, DigitBeginFlags=0x0,

Rtp Timestamp=0x0, Rtp Expiration=0x0

*Feb 27 00:27:47.130: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:47.130: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:47.130: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_BEGIN(19)] {

*Feb 27 00:27:47.134: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:47.134: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.134: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:47.134: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:47.134: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:47.134: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:47.270: //209/9DE891800000/CCAPI/cc_api_call_digit_end:

Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=0,

Source Call Id=209, Digit=2, Duration=160,

Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF

*Feb 27 00:27:47.270: //209/9DE891800000/CCAPI/cc_api_call_digit_end:

Call Entry(Handoff Depth=0)

*Feb 27 00:27:47.270: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:47.274: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:47.274: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_END(18)] {

*Feb 27 00:27:47.274: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:47.274: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.274: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:47.274: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:47.274: //209/9DE891800000/AFW_:/AFW_M_Leg_EventPreProcess: Passing, not enabled.---

*Feb 27 00:27:47.274: //-1//MSW :/msw_recrd_stop: genericStream=0x6847C1B8,

mediaStream=0x6A295288, rtspStream=0x6847CC44

reason=MSW_RECRD_REASON_INTERRUPTED current_state=MSW_S_IDLE

*Feb 27 00:27:47.274: //-1//MSW :/msw_recrd_stop: Stream not currently active

*Feb 27 00:27:47.274: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:27:47.274: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:27:47.274: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696D9DFC_0_73558152] (

*Feb 27 00:27:47.274: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.274: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:47.274: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:27:47.274: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.278: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696D9DFC_0_73558152] (

*Feb 27 00:27:47.278: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.278: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:47.278: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:27:47.278: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect

*Feb 27 00:27:47.278: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_696D9DFC_0_73558152

*Feb 27 00:27:47.278: //209//Digi:/AFW_M_DigitCollect_Action:

*Feb 27 00:27:47.278: //209//Digi:/act_DCRunning_Digit: : pLeg 209 Digit 2 Tone Mode 0

*Feb 27 00:27:47.278: //209//Digi:/DigitCollect_TreatDigit:

*Feb 27 00:27:47.278: //209//Digi:/DigitCollect_DialPlanMatch: pattern offset=0, digits=33332

*Feb 27 00:27:47.278: //209//Digi:/DigitCollect_DialPlanMatch: src carrier id:, tgt carrier id:

*Feb 27 00:27:47.278: //209//Digi:/DigitCollect_DialPlanMatch: Match single infotype

*Feb 27 00:27:47.278: //209/9DE891800000/AFW_:/AFW_Leg_DigitReportDisable: Current: 0x2 Input: 0x1

*Feb 27 00:27:47.282: //209/9DE891800000/CCAPI/ccCallReportDigits:

(callID=0xD1, digit_event=0x0, enable=FALSE, consume=FALSE)

*Feb 27 00:27:47.282: //209/9DE891800000/CCAPI/ccCallReportDigits:

Enabled=TRUE, Call Id=209

*Feb 27 00:27:47.282: //209/9DE891800000/CCAPI/cc_api_call_report_digits_done:

(vdbPtr=0x68263008, callID=0xD1, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE)

*Feb 27 00:27:47.282: //209/9DE891800000/CCAPI/cc_api_call_report_digits_done:

Enabled=TRUE, Disposition=0x0, Interface=0x68263008, Call Id=209

*Feb 27 00:27:47.282: //209/9DE891800000/CCAPI/cc_api_call_report_digits_done:

Call Entry(Initial Digit Timeout=10000(ms), Inter Digit Timeout=10000(ms))

*Feb 27 00:27:47.282: //209//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_696D9DFC_0_73558152 ---> NULL

*Feb 27 00:27:47.282: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:47.282: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:47.282: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:47.282: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:47.282: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_REPORT_DIGITS_DONE(68)] {

*Feb 27 00:27:47.282: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:47.282: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.282: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:47.282: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:47.282: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:27:47.286: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:27:47.286: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696D9DFC_0_73558152] (

*Feb 27 00:27:47.286: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.286: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:47.286: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:27:47.286: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.286: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696D9DFC_0_73558152] (

*Feb 27 00:27:47.286: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.286: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:47.286: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:27:47.286: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect

*Feb 27 00:27:47.286: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_696D9DFC_0_73558152

*Feb 27 00:27:47.286: //209//Digi:/AFW_M_DigitCollect_Action:

*Feb 27 00:27:47.286: //209//Digi:/act_DCRunning_RDone: id=209 Reporting disabled.

*Feb 27 00:27:47.286: //-1//Digi:/DigitCollect_Complete: DC_MATCHED_DIALPLAN. Digits=33332

*Feb 27 00:27:47.286: //209//Digi:/DigitCollect_MLPPPostAdjust: Non MLPP call

*Feb 27 00:27:47.286: //-1//AFW_:/AFW_Event_New: Event ID: ev_collectdigits_done

*Feb 27 00:27:47.286: //209//AFW_:/AFW_Module_ReturnArgEv:

*Feb 27 00:27:47.286: //209//AFW_:/AFW_Module_ReturnArgEv: Return List (remove=TRUE){LEG[209 ][LEG_INCCONNECTED(5)][Cause(0)]}

*Feb 27 00:27:47.286: //209/9DE891800000/AFW_:/AFW_Object_RemoveListener:

*Feb 27 00:27:47.286: //209//AFW_:/AFW_Module_UnListen: NumObjects: 0

*Feb 27 00:27:47.290: //209//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_696D9DFC_0_73558152 ---> NULL

*Feb 27 00:27:47.290: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:47.290: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:47.290: //209//AFW_:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED

*Feb 27 00:27:47.290: //209//AFW_:/AFW_Process_GetPriorityQEvent: Received

*Feb 27 00:27:47.290: //-1//AFW_:/AFW_Process_GetPriorityQEvent: Event[APP_EV_DIGITCOLLECT_DONE(228)] {

*Feb 27 00:27:47.290: //-1//AFW_:/AFW_Process_GetPriorityQEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:47.290: //-1//AFW_:/AFW_Process_GetPriorityQEvent: MOD[DigitCollect_696D9DFC_0_73558152] (

*Feb 27 00:27:47.290: //-1//AFW_:/AFW_Process_GetPriorityQEvent: )

*Feb 27 00:27:47.290: //-1//AFW_:/AFW_Process_GetPriorityQEvent: }

*Feb 27 00:27:47.290: //209//Digi:/AFW_M_DigitCollect_EventPreProcess:

*Feb 27 00:27:47.290: //209//Digi:/DigitCollectEnd_UpdateStats:

*Feb 27 00:27:47.290: //209//AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:27:47.290: //209//AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:27:47.290: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:27:47.290: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.290: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696D9DFC_0_73558152] (

*Feb 27 00:27:47.290: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:47.290: //209//AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:27:47.290: //209//AFW_:/AFW_Object_WalkListeners: Entering Module : TclModule

*Feb 27 00:27:47.290: //209/9DE891800000/AFW_:/AFW_Object_AddListener: adding Module TclModule as listener

*Feb 27 00:27:47.294: //209//AFW_:/AFW_Object_RemoveListener:

*Feb 27 00:27:47.294: //209//AFW_:/AFW_Module_UnListen: NumObjects: 1

*Feb 27 00:27:47.294: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> TclModule_6A43B178_0_73558128

*Feb 27 00:27:47.294: //209//AFW_:/AFW_M_TclModule_Action:

*Feb 27 00:27:47.294: //209//AFW_:/AFW_TclModule_DefaultEvHandling:

*Feb 27 00:27:47.294: //209//AFW_:/AFW_FSM_Drive: ACTION BEGIN: ------(GETDEST[3],ev_collectdigits_done[228])---[act_GotDest]------

*Feb 27 00:27:47.294: //209//TCL :/tcl_PutsObjCmd:

proc act_GotDest

*Feb 27 00:27:47.294:

*Feb 27 00:27:47.294: //209//TCL :/tcl_InfotagObjCmd: infotag get evt_status

*Feb 27 00:27:47.294: //209//TCL :/tcl_InfotagGetObjCmd: infotag get evt_status

*Feb 27 00:27:47.294: //209//AFW_:/vtr_ev_status: argc 2 argindex 2

*Feb 27 00:27:47.294: //209//TCL :/tcl_PutsObjCmd:

STATUS: cd_004

*Feb 27 00:27:47.294:

*Feb 27 00:27:47.294: //209//TCL :/tcl_PutsObjCmd:

MAXEXTENSION: 13

*Feb 27 00:27:47.294:

*Feb 27 00:27:47.294: //209//TCL :/tcl_InfotagObjCmd: infotag get evt_dcdigits

*Feb 27 00:27:47.294: //209//TCL :/tcl_InfotagGetObjCmd: infotag get evt_dcdigits

*Feb 27 00:27:47.294: //209//AFW_:/vtr_ev_dcdigits: argc 2

*Feb 27 00:27:47.294: //209//AFW_:/vtr_ev_dcdigits: DCDIGITS [33332]

*Feb 27 00:27:47.294: //209//TCL :/tcl_PutsObjCmd:

DESTLEN: 5

*Feb 27 00:27:47.294:

*Feb 27 00:27:47.294: //209//TCL :/tcl_PutsObjCmd:

extLength: 8

*Feb 27 00:27:47.298:

*Feb 27 00:27:47.298: //209//TCL :/tcl_PutsObjCmd:

DIGITS: 33332

*Feb 27 00:27:47.298:

*Feb 27 00:27:47.298: //209//TCL :/tcl_LegObjCmd: leg setup 33332 callInfo leg_incoming

*Feb 27 00:27:47.298: //209//CSPK:/tcl_LegSetupObjCmd: leg setup 33332 callInfo leg_incoming

*Feb 27 00:27:47.298: //209//AFW_:/vtd_lg_incoming: argc 4

*Feb 27 00:27:47.298: //209//AFW_:/vtd_lg_incoming: Legs [209 ]

*Feb 27 00:27:47.298: //209//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1

*Feb 27 00:27:47.298: //-1//AFW_:/AFW_Util_CopyCallDataToCallInfo: copied

*Feb 27 00:27:47.298: //-1/xxxxxxxxxxxx/CCAPI/ccGetMemPoolFromContainer:

mempool not found from usrContainer(6949F0A8)

*Feb 27 00:27:47.298: //-1/xxxxxxxxxxxx/CCAPI/ccCreateMemPoolInContainer:

Mempool(6A29B56C) created in usrContainer(6949F0A8)

*Feb 27 00:27:47.298: //-1//AFW_:/AFW_Util_GetUsrContainerData: Container is present, No data

*Feb 27 00:27:47.298: //-1//AFW_:/AFW_Util_CopyCallDataToCallInfo: Successful in setting 'CC_TAG_SETUP_REQ_DATA' in usrContainer(6949F0A8)

*Feb 27 00:27:47.298: ccDumpTdRequestDataGen:

*Feb 27 00:27:47.298: called_urip=NULL

*Feb 27 00:27:47.298: calling_urip=sip:30110@172.20.5.22

*Feb 27 00:27:47.298: url_dump_header_line_avpair:

*Feb 27 00:27:47.298: num_bodies = 0

*Feb 27 00:27:47.298: //-1//AFW_:/AFW_Util_CopyLegServiceCodeToCallInfoContainer: Service Code not available on Leg

*Feb 27 00:27:47.298: //-1//AFW_:/AFW_Util_CopyLegRouteCodeToCallInfoContainer: Route Code not available on Leg

*Feb 27 00:27:47.302: //-1//AFW_:/AFW_Util_GetTgCicValue: CIC Not found for tag(56)

*Feb 27 00:27:47.302: //-1//CSPK:/tclSetControlParams: alertTime(30) = 30

*Feb 27 00:27:47.302: //209//CSPK:/C_CallSetup_Start: ControlInfo = 0x6A439108, callInfo = 0x6A3F82AC, destination[0]=33332

*Feb 27 00:27:47.302: //209//CSPK:/C_CallSetup_Start: configured mode=rotary (1)

*Feb 27 00:27:47.302: //209//CSPK:/C_CallSetup_Start: configured reroutemode=rotary (1)

*Feb 27 00:27:47.302: //-1//Call:/AFW_CallSetup_New:

*Feb 27 00:27:47.302: //-1//AFW_:/AFW_FSM_New:

*Feb 27 00:27:47.302: //-1//AFW_:LP:EE681ABEBC000:HN0462AF5C:/AFW_M_Object_SetExecEnv: ObjCount: 4, CmdPending 1

*Feb 27 00:27:47.302: //209//AFW_:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 2

*Feb 27 00:27:47.302: //209//AFW_:/AFW_Object_AddListener: adding Module TclModule as listener

*Feb 27 00:27:47.302: //209//AFW_:/AFW_M_Module_GetHandle: Module handle: CallSetup_6A3524D0_0_73576284

*Feb 27 00:27:47.302: //209//Call:/AFW_CallSetup_AddDest: 33332 index 0

*Feb 27 00:27:47.302: //209//Call:/AFW_CallSetup_SetIntWrkLeg:

*Feb 27 00:27:47.302: //209/9DE891800000/AFW_:/AFW_Leg_SignalPeerGet: Leg [209]

*Feb 27 00:27:47.302: //-1//AFW_:/C_PackageSession_GetSigPeer:

*Feb 27 00:27:47.302: //209/9DE891800000/AFW_:/C_PackageSession_GetSigPeer: No Interworking module on Leg, no signal peer

*Feb 27 00:27:47.306: //209//Call:/AFW_M_CallSetup_Initiate:

*Feb 27 00:27:47.306: //209/9DE891800000/AFW_:/AFW_Leg_SetMLPPInfo: Unable to set mlpp info

*Feb 27 00:27:47.306: //-1//AFW_:/AFW_Util_CopyMLPPDataToCallInfoContainer: Voice MLPP not configured

*Feb 27 00:27:47.306: //209//Call:/CS_UpdateMLPPInfo: ServiceDomain:[none (0)] DomainIdentifier:[000000] PrecedenceLevel:[-1 (PRECEDENCE_LEVEL_NONE)] NormalizedPrecedence:[0 (INTERNAL_PRECEDENCE_0)] Preempt Hunt Not Set

*Feb 27 00:27:47.306: //209//Call:/CallSetupInitiate:

*Feb 27 00:27:47.306: //209//Call:/CS_Placecall:

*Feb 27 00:27:47.306: //209/9DE891800000/AFW_:/AFW_Leg_SetMLPPInfo: Unable to set mlpp info

*Feb 27 00:27:47.306: //-1//AFW_:/AFW_Util_CopyMLPPDataToCallInfoContainer: Voice MLPP not configured

*Feb 27 00:27:47.306: //-1//Dest:/AFW_Destination_New:

*Feb 27 00:27:47.306: //-1//AFW_:/AFW_FSM_New:

*Feb 27 00:27:47.306: //-1//AFW_:LP:EE681ABEBC000:HN0462AF60:/AFW_M_Object_SetExecEnv: ObjCount: 5, CmdPending 2

*Feb 27 00:27:47.306: //209//AFW_:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 3

*Feb 27 00:27:47.306: //209//AFW_:/AFW_Object_AddListener: adding Module CallSetup as listener

*Feb 27 00:27:47.306: //209//AFW_:/AFW_M_Module_GetHandle: Module handle: Destination_6A37F5E4_0_73576288

*Feb 27 00:27:47.306: //209//Dest:/AFW_Destination_AddDest:

*Feb 27 00:27:47.306: //-1//Dest:/AFW_Destination_AddDest: adding destination "33332"

*Feb 27 00:27:47.306: //209//Dest:/AFW_Destination_SetIntWrkLeg: LEG[209 ][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.310: //209//Dest:/TermInterworking: current state IW_STATE_INIT, Keep IntWrkLeg

*Feb 27 00:27:47.310: //209//Dest:/DestSetIntWrkLeg:

*Feb 27 00:27:47.310: //209/9DE891800000/AFW_:/AFW_Object_AddListener: adding Module Destination as listener

*Feb 27 00:27:47.310: //209//Dest:/AFW_M_Destination_Initiate:

*Feb 27 00:27:47.310: //-1//AFW_:/AFW_Util_SaveRawMsg:

*Feb 27 00:27:47.310: //209//Dest:/AFW_M_Destination_Initiate: Outgoing guid : 9DE89180.00010000.00000099.160514AC

*Feb 27 00:27:47.310: Incoming_guid : 00000000.00000000.00000000.00000000

*Feb 27 00:27:47.310: //209//Dest:/AFW_M_Destination_Initiate: Outgoing gcid : B7DB0478.DC1F11E5.813EF06D.617340D4

*Feb 27 00:27:47.310: Incoming_gcid : 00000000.00000000.00000000.00000000

*Feb 27 00:27:47.310: //209/9DE891800000/AFW_:/AFW_Leg_SetMLPPInfo: Unable to set mlpp info

*Feb 27 00:27:47.310: //-1//AFW_:/AFW_Util_CopyMLPPDataToCallInfoContainer: Voice MLPP not configured

*Feb 27 00:27:47.310: //209//Dest:/DestUpdateMLPPInfo: ServiceDomain:[none (0)] DomainIdentifier:[000000] PrecedenceLevel:[-1 (PRECEDENCE_LEVEL_NONE)] NormalizedPrecedence:[-1 (PRECEDENCE_LEVEL_NONE)] Preempt Hunt Not Set

*Feb 27 00:27:47.310: //209//Dest:/DestSetupInitiate:

*Feb 27 00:27:47.310: //209//Dest:/DestAddRerouteSetupInfo:

*Feb 27 00:27:47.310: //209//Dest:/DestAddTransferSetupInfo:

*Feb 27 00:27:47.310: //-1//AFW_:/AFW_Util_CopyCallDataToCallInfo: copied 33332

*Feb 27 00:27:47.310: //209//Dest:/DestMatchDialPeer:

*Feb 27 00:27:47.310: //209//Dest:/DestMatchDialPeer: src carrier id:, tgt carrier id:

*Feb 27 00:27:47.310: //209//Dest:/DestQueuePeers: Matched peers:

*Feb 27 00:27:47.310: //209//Dest:/DestPeerItemUpdatePreemptInfo:

*Feb 27 00:27:47.310: //209//Dest:/DestPeerItemResetLPCORInfo:

*Feb 27 00:27:47.314: //-1//Dest:/DestQueuePeers: 3333

*Feb 27 00:27:47.314: //-1//Dest:/DestQueuePeers: , Total(1)

*Feb 27 00:27:47.314: //209//Dest:/DestDialPeerRotary:

*Feb 27 00:27:47.314: //209//Dest:/DestOutboundCallUsingPeer: dest(33332), numexpDest(33332), numDestDigits(1)

*Feb 27 00:27:47.314: //209//Dest:/DestOutboundCallUsingPeer: prefix(.22), peer tag(3333)

*Feb 27 00:27:47.314: //209//Dest:/DestUpdatePreemptSetupInfo:

*Feb 27 00:27:47.314: //-1//AFW_:/AFW_Util_RemovePreemptInfoFromContainer: Failed to remove mlppSetupInfo from TD container

*Feb 27 00:27:47.314: //209//Dest:/DestDialPeerFilter:

*Feb 27 00:27:47.314: //209//Dest:/DestDialPeerFilter: Checking peer [3333]

*Feb 27 00:27:47.314: //209//Dest:/DestPeerFilterRouteCode: Route Code not available

*Feb 27 00:27:47.314: //-1//Dest:/DestOutboundCallUsingPeer: Outgoing Tag(3333) calling[30110] called[33332]

*Feb 27 00:27:47.314: //209//Dest:/DestCheckTeleUnassBusy:

*Feb 27 00:27:47.314: //209//Dest:/DestHandleLPCOR:

*Feb 27 00:27:47.314: //209//Dest:/DestSetup:

*Feb 27 00:27:47.314: //-1//AFW_:/AFW_Leg_New:

*Feb 27 00:27:47.314: //209/9DE891800000/CCAPI/ccCallSetupRequest:

Destination=, Calling IE Present=TRUE, Mode=0,

Outgoing Dial-peer=3333, Params=0x696BA008, Progress Indication=NULL(0)

*Feb 27 00:27:47.314: //209/9DE891800000/CCAPI/ccCheckClipClir:

In: Calling Number=sip:30110@172.20.5.22(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

*Feb 27 00:27:47.314: //209/9DE891800000/CCAPI/ccCheckClipClir:

Out: Calling Number=sip:30110@172.20.5.22(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)

*Feb 27 00:27:47.314: //209/9DE891800000/CCAPI/ccCallSetupRequest:

Destination Pattern=3...., Called Number=33332, Digit Strip=FALSE

*Feb 27 00:27:47.314: //209/9DE891800000/CCAPI/ccCallSetupRequest:

Calling Number=sip:30110@172.20.5.22(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=33332(TON=Unknown, NPI=Unknown),

Redirect Number=, Display Info=

Account Number=30110, Final Destination Flag=TRUE,

Guid=9DE89180-0001-0000-0000-0099160514AC, Outgoing Dial-peer=3333

*Feb 27 00:27:47.314: //209/9DE891800000/CCAPI/cc_api_display_ie_subfields:

ccCallSetupRequest:

cisco-username=30110

----- ccCallInfo IE subfields -----

cisco-ani=sip:30110@172.20.5.22

cisco-anitype=0

cisco-aniplan=0

cisco-anipi=0

cisco-anisi=0

dest=33332

cisco-desttype=0

cisco-destplan=0

cisco-rdie=FFFFFFFF

cisco-rdn=

cisco-rdntype=0

cisco-rdnplan=0

cisco-rdnpi=-1

cisco-rdnsi=-1

cisco-redirectreason=-1 fwd_final_type =0

final_redirectNumber =

hunt_group_timeout =0

*Feb 27 00:27:47.318: //209/9DE891800000/CCAPI/ccIFCallSetupRequestPrivate:

Interface=0x68263008, Interface Type=3, Destination=, Mode=0x0,

Call Params(Calling Number=sip:30110@172.20.5.22,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),

Called Number=33332(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,

Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=3333, Call Count On=FALSE,

Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)

*Feb 27 00:27:47.318: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Feb 27 00:27:47.318: :cc_get_feature_vsa malloc success

*Feb 27 00:27:47.318: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Feb 27 00:27:47.318: cc_get_feature_vsa count is 2

*Feb 27 00:27:47.318: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Feb 27 00:27:47.318: :FEATURE_VSA attributes are: feature_name:0,feature_time:1729742688,feature_id:106

*Feb 27 00:27:47.318: //212/9DE891800000/CCAPI/ccIFCallSetupRequestPrivate:

SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1

*Feb 27 00:27:47.318: //212/9DE891800000/AFW_:/AFW_Leg_NewSetupRequest: ccCallSetupRequest done

*Feb 27 00:27:47.318: //212/9DE891800000/CCAPI/ccCallSetContext:

Context=0x696B9FB8

*Feb 27 00:27:47.322: //209/9DE891800000/CCAPI/ccSaveDialpeerTag:

Outgoing Dial-peer=3333

*Feb 27 00:27:47.322: //212/9DE891800000/AFW_:/AFW_M_Leg_SetExecEnv:

*Feb 27 00:27:47.322: //209//AFW_:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 4

*Feb 27 00:27:47.322: //-1/9DE891800000/AFW_:LP:EE681ABEBC000:LG212:/AFW_M_Object_SetExecEnv: ObjCount: 6, CmdPending 4

*Feb 27 00:27:47.322: //212/9DE891800000/AFW_:/AFW_Object_AddListener: adding Module Destination as listener

*Feb 27 00:27:47.322: //212/9DE891800000/AFW_:/AFW_M_Leg_GetHandle: Leg handle: LEG_212

*Feb 27 00:27:47.322: //212/9DE891800000/AFW_:/AFW_Leg_UpdateStats: Updating stats for ID 3A type 3

*Feb 27 00:27:47.322: //209//Dest:/DestSetup: Destination setup success

*Feb 27 00:27:47.322: //209//Dest:/AFW_M_Destination_Initiate: attempting call to destination 33332

*Feb 27 00:27:47.322: //209//Call:/CS_Placecall: Call placed to 33332 index 0

*Feb 27 00:27:47.322: //209//AFW_:/AFW_FSM_Drive: ACTION END: -------------(HANDOFF[4])---------------

*Feb 27 00:27:47.322: //209//AFW_:/AFW_ExecEnv_SetModuleScope: TclModule_6A43B178_0_73558128 ---> NULL

*Feb 27 00:27:47.322: //209//AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:27:47.322: //209//AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:27:47.322: //209//AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:27:47.322: //209//AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:47.322: //209//AFW_:/AFW_M_Event_Free: MODULEDONEEVENT for a Module: DigitCollect_696D9DFC_0_73558152

*Feb 27 00:27:47.322: //209//AFW_:/AFW_Object_RemoveAllListener:

*Feb 27 00:27:47.322: //-1//AFW_:/AFW_M_Object_UnSetExecEnv: ObjCount: 5, CmdPending 4

*Feb 27 00:27:47.322: //-1//AFW_:HN04626888:/AFW_M_Event_Free: ExecEnv objCount: 5

*Feb 27 00:27:47.326: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 4

*Feb 27 00:27:47.326: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:47.326: //-1//AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:47.326: //-1//AFW_:/AFW_M_Event_Free: Null or invalid event context: for event APP_EV_NULL

*Feb 27 00:27:47.326: //212/9DE891800000/SIP/Error/ccsip_ipipms_peer_chnl_ind_hdlr: Peer caps is NULL

*Feb 27 00:27:47.330: //212/9DE891800000/CCAPI/cc_api_call_proceeding:

Interface=0x68263008, Progress Indication=NULL(0)

SIP: (212) Group (a= group line) attribute, level 65535 instance 1 not found.

*Feb 27 00:27:47.338: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:47.338: //212/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:47.338: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_PROCEEDING(31)] {

*Feb 27 00:27:47.338: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:47.338: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[212][LEG_OUTINIT(7)][Cause(0)]

*Feb 27 00:27:47.338: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:47.338: //212/9DE891800000/SSIN:/AFW_SS_MapEvent:

*Feb 27 00:27:47.338: //-1//SSIN:/AFW_SS_SIP_MapEvent:

*Feb 27 00:27:47.338: //212/9DE891800000/AFW_:/AFW_M_Leg_EventPreProcess: LEG[212 ][LEG_OUTINIT(7)][Cause(0)]

*Feb 27 00:27:47.338: //212/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:27:47.338: //212/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:27:47.338: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_6A37F5E4_0_73576288] (

*Feb 27 00:27:47.338: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[212][LEG_OUTINIT(7)][Cause(0)]

*Feb 27 00:27:47.338: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.338: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:47.338: //212/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:27:47.342: //212/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : Destination

*Feb 27 00:27:47.342: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> Destination_6A37F5E4_0_73576288

*Feb 27 00:27:47.342: //209//Dest:/AFW_M_Destination_Action:

*Feb 27 00:27:47.342: //209//Dest:/AFW_Destination_Action:

*Feb 27 00:27:47.342: //209//Dest:/OB_FSM_Drive:

*Feb 27 00:27:47.342: //209//AFW_:/AFW_ExecEnv_SetModuleScope: Destination_6A37F5E4_0_73576288 ---> Destination_6A37F5E4_0_73576288

*Feb 27 00:27:47.342: //209//AFW_:/AFW_FSM_Drive: ACTION BEGIN: ------(OB_STATE_SETTING[3],ev_proceeding[31])---[C_Action]------

*Feb 27 00:27:47.342: //209//Dest:/OB_Setting_Proceeding:

*Feb 27 00:27:47.342: //209//AFW_:/AFW_FSM_Drive: ACTION END: -------------(OB_STATE_SETTING[3])---------------

*Feb 27 00:27:47.342: //209//AFW_:/AFW_ExecEnv_SetModuleScope: Destination_6A37F5E4_0_73576288 ---> Destination_6A37F5E4_0_73576288

*Feb 27 00:27:47.342: //209//Dest:/IW_FSM_Drive:

*Feb 27 00:27:47.342: //209//AFW_:/AFW_ExecEnv_SetModuleScope: Destination_6A37F5E4_0_73576288 ---> Destination_6A37F5E4_0_73576288

*Feb 27 00:27:47.342: //209//AFW_:/AFW_FSM_Drive: ACTION BEGIN: ------(IW_STATE_INIT[1],ev_proceeding[31])---[C_Action]------

*Feb 27 00:27:47.342: //209//Dest:/IW_InitProc_Proceeding:

*Feb 27 00:27:47.342: //209//AFW_:/AFW_FSM_Drive: ACTION END: -------------(IW_STATE_INIT[1])---------------

*Feb 27 00:27:47.342: //209//AFW_:/AFW_ExecEnv_SetModuleScope: Destination_6A37F5E4_0_73576288 ---> Destination_6A37F5E4_0_73576288

*Feb 27 00:27:47.342: //209//Dest:/DestIsEventNotified:

*Feb 27 00:27:47.342: //209//Dest:/DestComplete: peer #:3333 IW State IW_STATE_INIT, OB State OB_STATE_SETTING

*Feb 27 00:27:47.342: //209//AFW_:/AFW_ExecEnv_SetModuleScope: Destination_6A37F5E4_0_73576288 ---> NULL

*Feb 27 00:27:47.342: //212/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:47.342: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 4

*Feb 27 00:27:47.350: //212/9DE891800000/CCAPI/cc_api_call_disconnected:

Cause Value=1, Interface=0x68263008, Call Id=212

*Feb 27 00:27:47.350: //212/9DE891800000/CCAPI/cc_api_call_disconnected:

Call Entry(Responsed=TRUE, Cause Value=1, Retry Count=0)

*Feb 27 00:27:47.350: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:47.350: //212/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:47.350: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DISCONNECTED(20)] {

*Feb 27 00:27:47.350: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:47.354: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[212][LEG_OUTPROCEED(8)][Cause(0)]

*Feb 27 00:27:47.354: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:47.354: //212/9DE891800000/SSIN:/AFW_SS_MapEvent:

*Feb 27 00:27:47.354: //-1//SSIN:/AFW_SS_SIP_MapEvent:

*Feb 27 00:27:47.354: //212/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:27:47.354: //212/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:27:47.354: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_6A37F5E4_0_73576288] (

*Feb 27 00:27:47.354: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[212][LEG_OUTPROCEED(8)][Cause(1)]

*Feb 27 00:27:47.354: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:47.354: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:47.354: //212/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:27:47.354: //212/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : Destination

*Feb 27 00:27:47.354: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> Destination_6A37F5E4_0_73576288

*Feb 27 00:27:47.354: //209//Dest:/AFW_M_Destination_Action:

*Feb 27 00:27:47.354: //209//Dest:/AFW_Destination_Action:

*Feb 27 00:27:47.354: //209//Dest:/OB_FSM_Drive:

*Feb 27 00:27:47.354: //209//AFW_:/AFW_ExecEnv_SetModuleScope: Destination_6A37F5E4_0_73576288 ---> Destination_6A37F5E4_0_73576288

*Feb 27 00:27:47.354: //209//AFW_:/AFW_FSM_Drive: ACTION BEGIN: ------(OB_STATE_SETTING[3],ev_disconnected[20])---[C_Action]------

*Feb 27 00:27:47.354: //209//Dest:/OB_Setting_Disconnected:

*Feb 27 00:27:47.354: //209//Dest:/OBDiscContinue:

*Feb 27 00:27:47.354: //209/9DE891800000/CCAPI/ccCallReleaseResources:

release reserved xcoding resource.

*Feb 27 00:27:47.354: //209//Dest:/resetAppAlertTimer:

*Feb 27 00:27:47.354: //209//Dest:/Dest_AAA_CheckAccounting:

*Feb 27 00:27:47.358: //209//Dest:/Dest_AAA_CheckAccounting: accounting to be enabled for callID=212

*Feb 27 00:27:47.358: //212/9DE891800000/CCAPI/ccCallSetAAA_Accounting:

Accounting=0, Call Id=212

*Feb 27 00:27:47.358: //212/9DE891800000/AFW_:/AFW_Leg_Disconnect: Disconnecting Leg: LEG_212

*Feb 27 00:27:47.358: //212/9DE891800000/AFW_:/AFW_Leg_Disconnect: Disconnecting Leg: LEG_212, Cause 1

*Feb 27 00:27:47.358: //212/9DE891800000/AFW_:/AFW_Leg_UpdateStats: Updating stats for ID 3A type 2

*Feb 27 00:27:47.358: //212/9DE891800000/CCAPI/ccCallDisconnect:

Cause Value=1, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=1)

*Feb 27 00:27:47.358: //212/9DE891800000/CCAPI/ccCallDisconnect:

Cause Value=1, Call Entry(Responsed=TRUE, Cause Value=1)

*Feb 27 00:27:47.358: //-1//Dest:/DestStatusFromDiscCause: mapped "unassigned number (1)"(1) to DEST_INVALID_NUMBER(4)

*Feb 27 00:27:47.358: //209//AFW_:/AFW_FSM_Drive: ACTION END: -------------(OB_STATE_DISCONNECTING[6])---------------

*Feb 27 00:27:47.358: //209//AFW_:/AFW_ExecEnv_SetModuleScope: Destination_6A37F5E4_0_73576288 ---> Destination_6A37F5E4_0_73576288

*Feb 27 00:27:47.358: //209//Dest:/IW_FSM_Drive:

*Feb 27 00:27:47.358: //209//AFW_:/AFW_ExecEnv_SetModuleScope: Destination_6A37F5E4_0_73576288 ---> Destination_6A37F5E4_0_73576288

*Feb 27 00:27:47.358: //209//AFW_:/AFW_FSM_Drive: ACTION BEGIN: ------(IW_STATE_INIT[1],ev_disconnected[20])---[C_Action]------

*Feb 27 00:27:47.358: //209//Dest:/IW_InitProc_Disconnect:

*Feb 27 00:27:47.358: //209//AFW_:/AFW_FSM_Drive: ACTION END: -------------(IW_STATE_INIT[1])---------------

*Feb 27 00:27:47.358: //209//AFW_:/AFW_ExecEnv_SetModuleScope: Destination_6A37F5E4_0_73576288 ---> Destination_6A37F5E4_0_73576288

*Feb 27 00:27:47.358: //209//Dest:/DestIsEventNotified:

*Feb 27 00:27:47.358: //209//Dest:/DestComplete: peer #:3333 IW State IW_STATE_INIT, OB State OB_STATE_DISCONNECTING

*Feb 27 00:27:47.358: //209//AFW_:/AFW_ExecEnv_SetModuleScope: Destination_6A37F5E4_0_73576288 ---> NULL

*Feb 27 00:27:47.358: //212/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:47.358: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 4

*Feb 27 00:27:47.362: //212/9DE891800000/CCAPI/cc_api_call_disconnect_done:

Disposition=0, Interface=0x68263008, Tag=0x0, Call Id=212,

Call Entry(Disconnect Cause=1, Voice Class Cause Code=0, Retry Count=0)

*Feb 27 00:27:47.726: //209//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_696DA084_0_73576372 ---> NULL

*Feb 27 00:27:47.726: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:47.726: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:48.210: //209/9DE891800000/CCAPI/cc_api_call_digit_begin:

Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=0,

Source Call Id=209, Digit=2, DigitBeginFlags=0x0,

Rtp Timestamp=0x0, Rtp Expiration=0x0

*Feb 27 00:27:48.210: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:48.210: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:48.214: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_BEGIN(19)] {

*Feb 27 00:27:48.214: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:48.214: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:48.214: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:48.214: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:48.214: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:48.214: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:48.350: //209/9DE891800000/CCAPI/cc_api_call_digit_end:

Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=0,

Source Call Id=209, Digit=2, Duration=160,

Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF

*Feb 27 00:27:48.350: //209/9DE891800000/CCAPI/cc_api_call_digit_end:

Call Entry(Handoff Depth=0)

*Feb 27 00:27:48.350: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:48.354: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:48.354: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_END(18)] {

*Feb 27 00:27:48.354: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:48.354: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:48.354: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:48.354: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:48.354: //209/9DE891800000/AFW_:/AFW_M_Leg_EventPreProcess: Passing, not enabled.---

*Feb 27 00:27:48.354: //-1//MSW :/msw_recrd_stop: genericStream=0x6847C1B8,

mediaStream=0x6A295288, rtspStream=0x6847CC44

reason=MSW_RECRD_REASON_INTERRUPTED current_state=MSW_S_IDLE

*Feb 27 00:27:48.354: //-1//MSW :/msw_recrd_stop: Stream not currently active

*Feb 27 00:27:48.354: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:27:48.354: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:27:48.354: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:27:48.354: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:48.354: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:48.354: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:27:48.354: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:27:48.358: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:48.358: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:48.358: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:48.358: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:48.358: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:27:48.358: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect

*Feb 27 00:27:48.358: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_696DA084_0_73576372

*Feb 27 00:27:48.358: //209//Digi:/AFW_M_DigitCollect_Action:

*Feb 27 00:27:48.358: //209//Digi:/act_DCRunning_Digit: : pLeg 209 Digit 2 Tone Mode 0

*Feb 27 00:27:48.358: //209//Digi:/DigitCollect_TreatDigit:

*Feb 27 00:27:48.358: //209//Digi:/DigitCollect_DialPlanMatch: pattern offset=0, digits=02

*Feb 27 00:27:48.358: //209//Digi:/DigitCollect_DialPlanMatch: src carrier id:, tgt carrier id:

*Feb 27 00:27:48.358: //209//Digi:/DigitCollect_DialPlanMatch: Match single infotype

*Feb 27 00:27:48.358: //209//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_696DA084_0_73576372 ---> NULL

*Feb 27 00:27:48.358: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:48.362: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:48.710: //209/9DE891800000/CCAPI/cc_api_call_digit_begin:

Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=0,

Source Call Id=209, Digit=5, DigitBeginFlags=0x0,

Rtp Timestamp=0x0, Rtp Expiration=0x0

*Feb 27 00:27:48.710: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:48.710: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:48.710: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_BEGIN(19)] {

*Feb 27 00:27:48.714: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:48.714: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:48.714: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:48.714: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:48.714: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:48.714: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:48.850: //209/9DE891800000/CCAPI/cc_api_call_digit_end:

Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=0,

Source Call Id=209, Digit=5, Duration=160,

Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF

*Feb 27 00:27:48.850: //209/9DE891800000/CCAPI/cc_api_call_digit_end:

Call Entry(Handoff Depth=0)

*Feb 27 00:27:48.850: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:48.854: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:48.854: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_END(18)] {

*Feb 27 00:27:48.854: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:48.854: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:48.854: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:48.854: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:48.854: //209/9DE891800000/AFW_:/AFW_M_Leg_EventPreProcess: Passing, not enabled.---

*Feb 27 00:27:48.854: //-1//MSW :/msw_recrd_stop: genericStream=0x6847C1B8,

mediaStream=0x6A295288, rtspStream=0x6847CC44

reason=MSW_RECRD_REASON_INTERRUPTED current_state=MSW_S_IDLE

*Feb 27 00:27:48.854: //-1//MSW :/msw_recrd_stop: Stream not currently active

*Feb 27 00:27:48.854: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:27:48.854: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:27:48.854: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:27:48.854: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:48.854: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:48.854: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:27:48.854: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:27:48.858: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:48.858: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:48.858: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:48.858: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:48.858: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:27:48.858: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect

*Feb 27 00:27:48.858: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_696DA084_0_73576372

*Feb 27 00:27:48.858: //209//Digi:/AFW_M_DigitCollect_Action:

*Feb 27 00:27:48.858: //209//Digi:/act_DCRunning_Digit: : pLeg 209 Digit 5 Tone Mode 0

*Feb 27 00:27:48.858: //209//Digi:/DigitCollect_TreatDigit:

*Feb 27 00:27:48.858: //209//Digi:/DigitCollect_DialPlanMatch: pattern offset=0, digits=025

*Feb 27 00:27:48.858: //209//Digi:/DigitCollect_DialPlanMatch: src carrier id:, tgt carrier id:

*Feb 27 00:27:48.858: //209//Digi:/DigitCollect_DialPlanMatch: Match single infotype

*Feb 27 00:27:48.858: //209//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_696DA084_0_73576372 ---> NULL

*Feb 27 00:27:48.858: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:48.858: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:49.210: //209/9DE891800000/CCAPI/cc_api_call_digit_begin:

Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=0,

Source Call Id=209, Digit=7, DigitBeginFlags=0x0,

Rtp Timestamp=0x0, Rtp Expiration=0x0

*Feb 27 00:27:49.210: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:49.210: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:49.214: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_BEGIN(19)] {

*Feb 27 00:27:49.214: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:49.214: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:49.214: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:49.214: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:49.214: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:49.214: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:49.350: //209/9DE891800000/CCAPI/cc_api_call_digit_end:

Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=0,

Source Call Id=209, Digit=7, Duration=160,

Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF

*Feb 27 00:27:49.350: //209/9DE891800000/CCAPI/cc_api_call_digit_end:

Call Entry(Handoff Depth=0)

*Feb 27 00:27:49.350: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:49.354: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:49.354: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_END(18)] {

*Feb 27 00:27:49.354: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:49.354: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:49.354: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:49.354: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:49.354: //209/9DE891800000/AFW_:/AFW_M_Leg_EventPreProcess: Passing, not enabled.---

*Feb 27 00:27:49.354: //-1//MSW :/msw_recrd_stop: genericStream=0x6847C1B8,

mediaStream=0x6A295288, rtspStream=0x6847CC44

reason=MSW_RECRD_REASON_INTERRUPTED current_state=MSW_S_IDLE

*Feb 27 00:27:49.354: //-1//MSW :/msw_recrd_stop: Stream not currently active

*Feb 27 00:27:49.354: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:27:49.354: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:27:49.354: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:27:49.354: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:49.354: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:49.354: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:27:49.358: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:27:49.358: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:49.358: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:49.358: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:49.358: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:49.358: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:27:49.358: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect

*Feb 27 00:27:49.358: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_696DA084_0_73576372

*Feb 27 00:27:49.358: //209//Digi:/AFW_M_DigitCollect_Action:

*Feb 27 00:27:49.358: //209//Digi:/act_DCRunning_Digit: : pLeg 209 Digit 7 Tone Mode 0

*Feb 27 00:27:49.358: //209//Digi:/DigitCollect_TreatDigit:

*Feb 27 00:27:49.358: //209//Digi:/DigitCollect_DialPlanMatch: pattern offset=0, digits=0257

*Feb 27 00:27:49.358: //209//Digi:/DigitCollect_DialPlanMatch: src carrier id:, tgt carrier id:

*Feb 27 00:27:49.358: //209//Digi:/DigitCollect_DialPlanMatch: Match single infotype

*Feb 27 00:27:49.358: //209//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_696DA084_0_73576372 ---> NULL

*Feb 27 00:27:49.362: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:49.362: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:50.070: //209/9DE891800000/CCAPI/cc_api_call_digit_begin:

Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=0,

Source Call Id=209, Digit=0, DigitBeginFlags=0x0,

Rtp Timestamp=0x0, Rtp Expiration=0x0

*Feb 27 00:27:50.070: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:50.070: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:50.074: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_BEGIN(19)] {

*Feb 27 00:27:50.074: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:50.074: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:50.074: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:50.074: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:50.074: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:50.074: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:27:50.210: //209/9DE891800000/CCAPI/cc_api_call_digit_end:

Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=0,

Source Call Id=209, Digit=0, Duration=160,

Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF

*Feb 27 00:27:50.210: //209/9DE891800000/CCAPI/cc_api_call_digit_end:

Call Entry(Handoff Depth=0)

*Feb 27 00:27:50.210: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:27:50.214: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:27:50.214: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_END(18)] {

*Feb 27 00:27:50.214: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:27:50.214: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:50.214: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:27:50.214: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:27:50.214: //209/9DE891800000/AFW_:/AFW_M_Leg_EventPreProcess: Passing, not enabled.---

*Feb 27 00:27:50.214: //-1//MSW :/msw_recrd_stop: genericStream=0x6847C1B8,

mediaStream=0x6A295288, rtspStream=0x6847CC44

reason=MSW_RECRD_REASON_INTERRUPTED current_state=MSW_S_IDLE

*Feb 27 00:27:50.214: //-1//MSW :/msw_recrd_stop: Stream not currently active

*Feb 27 00:27:50.214: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:27:50.214: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:27:50.214: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:27:50.214: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:50.214: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:50.214: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:27:50.214: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:27:50.218: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:50.218: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:50.218: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:27:50.218: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:27:50.218: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:27:50.218: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect

*Feb 27 00:27:50.218: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_696DA084_0_73576372

*Feb 27 00:27:50.218: //209//Digi:/AFW_M_DigitCollect_Action:

*Feb 27 00:27:50.218: //209//Digi:/act_DCRunning_Digit: : pLeg 209 Digit 0 Tone Mode 0

*Feb 27 00:27:50.218: //209//Digi:/DigitCollect_TreatDigit:

*Feb 27 00:27:50.218: //209//Digi:/DigitCollect_DialPlanMatch: pattern offset=0, digits=02570

*Feb 27 00:27:50.218: //209//Digi:/DigitCollect_DialPlanMatch: src carrier id:, tgt carrier id:

*Feb 27 00:27:50.218: //209//Digi:/DigitCollect_DialPlanMatch: Match single infotype

*Feb 27 00:27:50.218: //209//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_696DA084_0_73576372 ---> NULL

*Feb 27 00:27:50.218: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:27:50.218: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:28:00.210: //209/9DE891800000/CCAPI/cc_handle_inter_digit_timer:

Generate inter-digit timeout CC_EV_CALL_DIGIT_END event

*Feb 27 00:28:00.210: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:28:00.210: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:28:00.210: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_END(18)] {

*Feb 27 00:28:00.210: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:28:00.210: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.210: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:28:00.210: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:28:00.210: //209/9DE891800000/AFW_:/AFW_M_Leg_EventPreProcess: Passing, not enabled.---

*Feb 27 00:28:00.210: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:28:00.210: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:28:00.210: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:28:00.210: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.210: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:00.214: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:28:00.214: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:28:00.214: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.214: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:00.214: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.214: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:00.214: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:28:00.214: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect

*Feb 27 00:28:00.214: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_696DA084_0_73576372

*Feb 27 00:28:00.214: //209//Digi:/AFW_M_DigitCollect_Action:

*Feb 27 00:28:00.214: //209//Digi:/act_DCRunning_Digit: : pLeg 209 Digit T Tone Mode -1

*Feb 27 00:28:00.214: //209//Digi:/DigitCollect_TreatDigit:

*Feb 27 00:28:00.214: //209//Digi:/DigitCollect_DialPlanMatch: pattern offset=0, digits=02570T

*Feb 27 00:28:00.214: //209//Digi:/DigitCollect_DialPlanMatch: src carrier id:, tgt carrier id:

*Feb 27 00:28:00.218: //209//Digi:/DigitCollect_DialPlanMatch: Match single infotype

*Feb 27 00:28:00.218: //209/9DE891800000/AFW_:/AFW_Leg_DigitReportDisable: Current: 0x2 Input: 0x1

*Feb 27 00:28:00.218: //209/9DE891800000/CCAPI/ccCallReportDigits:

(callID=0xD1, digit_event=0x0, enable=FALSE, consume=FALSE)

*Feb 27 00:28:00.218: //209/9DE891800000/CCAPI/ccCallReportDigits:

Enabled=TRUE, Call Id=209

*Feb 27 00:28:00.218: //209/9DE891800000/CCAPI/cc_api_call_report_digits_done:

(vdbPtr=0x68263008, callID=0xD1, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE)

*Feb 27 00:28:00.218: //209/9DE891800000/CCAPI/cc_api_call_report_digits_done:

Enabled=TRUE, Disposition=0x0, Interface=0x68263008, Call Id=209

*Feb 27 00:28:00.218: //209/9DE891800000/CCAPI/cc_api_call_report_digits_done:

Call Entry(Initial Digit Timeout=10000(ms), Inter Digit Timeout=10000(ms))

*Feb 27 00:28:00.218: //209//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_696DA084_0_73576372 ---> NULL

*Feb 27 00:28:00.218: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:00.218: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:28:00.218: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:28:00.218: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_REPORT_DIGITS_DONE(68)] {

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:28:00.222: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:28:00.222: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:28:00.222: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.222: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:00.222: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:28:00.222: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect

*Feb 27 00:28:00.222: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_696DA084_0_73576372

*Feb 27 00:28:00.222: //209//Digi:/AFW_M_DigitCollect_Action:

*Feb 27 00:28:00.222: //209//Digi:/act_DCRunning_RDone: id=209 Reporting disabled.

*Feb 27 00:28:00.226: //-1//Digi:/DigitCollect_Complete: DC_INVALID_NUMBER. Digits=02570T

*Feb 27 00:28:00.226: //209//Digi:/DigitCollect_MLPPPostAdjust: Non MLPP call

*Feb 27 00:28:00.226: //-1//AFW_:/AFW_Event_New: Event ID: ev_collectdigits_done

*Feb 27 00:28:00.226: //209//AFW_:/AFW_Module_ReturnArgEv:

*Feb 27 00:28:00.226: //209//AFW_:/AFW_Module_ReturnArgEv: Return List (remove=TRUE){LEG[209 ][LEG_INCCONNECTED(5)][Cause(0)]}

*Feb 27 00:28:00.226: //209/9DE891800000/AFW_:/AFW_Object_RemoveListener:

*Feb 27 00:28:00.226: //209//AFW_:/AFW_Module_UnListen: NumObjects: 0

*Feb 27 00:28:00.226: //209//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_696DA084_0_73576372 ---> NULL

*Feb 27 00:28:00.226: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:00.226: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:28:00.226: //209//AFW_:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED

*Feb 27 00:28:00.226: //209//AFW_:/AFW_Process_GetPriorityQEvent: Received

*Feb 27 00:28:00.226: //-1//AFW_:/AFW_Process_GetPriorityQEvent: Event[APP_EV_DIGITCOLLECT_DONE(228)] {

*Feb 27 00:28:00.226: //-1//AFW_:/AFW_Process_GetPriorityQEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:28:00.226: //-1//AFW_:/AFW_Process_GetPriorityQEvent: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:28:00.226: //-1//AFW_:/AFW_Process_GetPriorityQEvent: )

*Feb 27 00:28:00.226: //-1//AFW_:/AFW_Process_GetPriorityQEvent: }

*Feb 27 00:28:00.226: //209//Digi:/AFW_M_DigitCollect_EventPreProcess:

*Feb 27 00:28:00.226: //209//Digi:/DigitCollectEnd_UpdateStats:

*Feb 27 00:28:00.226: //209//AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:28:00.226: //209//AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:28:00.226: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:28:00.226: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA084_0_73576372] (

*Feb 27 00:28:00.230: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:00.230: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.230: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:00.230: //209//AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:28:00.230: //209//AFW_:/AFW_Object_WalkListeners: Entering Module : TclModule

*Feb 27 00:28:00.230: //209/9DE891800000/AFW_:/AFW_Object_AddListener: adding Module TclModule as listener

*Feb 27 00:28:00.230: //209//AFW_:/AFW_Object_RemoveListener:

*Feb 27 00:28:00.230: //209//AFW_:/AFW_Module_UnListen: NumObjects: 1

*Feb 27 00:28:00.230: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> TclModule_6A43B178_0_73558128

*Feb 27 00:28:00.230: //209//AFW_:/AFW_M_TclModule_Action:

*Feb 27 00:28:00.230: //209//AFW_:/AFW_TclModule_DefaultEvHandling:

*Feb 27 00:28:00.230: //209//AFW_:/AFW_FSM_Drive: ACTION BEGIN: ------(GETDEST[3],ev_collectdigits_done[228])---[act_GotDest]------

*Feb 27 00:28:00.230: //209//TCL :/tcl_PutsObjCmd:

proc act_GotDest

*Feb 27 00:28:00.230:

*Feb 27 00:28:00.230: //209//TCL :/tcl_InfotagObjCmd: infotag get evt_status

*Feb 27 00:28:00.230: //209//TCL :/tcl_InfotagGetObjCmd: infotag get evt_status

*Feb 27 00:28:00.230: //209//AFW_:/vtr_ev_status: argc 2 argindex 2

*Feb 27 00:28:00.230: //209//TCL :/tcl_PutsObjCmd:

STATUS: cd_006

*Feb 27 00:28:00.230:

*Feb 27 00:28:00.230: //209//TCL :/tcl_PutsObjCmd:

MAXEXTENSION: 13

*Feb 27 00:28:00.230:

*Feb 27 00:28:00.230: //209//TCL :/tcl_InfotagObjCmd: infotag get con_all

*Feb 27 00:28:00.230: //209//TCL :/tcl_InfotagGetObjCmd: infotag get con_all

*Feb 27 00:28:00.234: //209//AFW_:/vtr_co_all: argc 2

*Feb 27 00:28:00.234: //209//AFW_:/vtr_co_all: EV_CONNECTIONS []

*Feb 27 00:28:00.234: //209//TCL :/tcl_PutsObjCmd:

Call got event cd_006 collecting destination

*Feb 27 00:28:00.234:

*Feb 27 00:28:00.234: //209//TCL :/tcl_InfotagObjCmd: infotag get evt_dcdigits

*Feb 27 00:28:00.234: //209//TCL :/tcl_InfotagGetObjCmd: infotag get evt_dcdigits

*Feb 27 00:28:00.234: //209//AFW_:/vtr_ev_dcdigits: argc 2

*Feb 27 00:28:00.234: //209//AFW_:/vtr_ev_dcdigits: DCDIGITS [02570]

*Feb 27 00:28:00.234: //209//TCL :/tcl_PutsObjCmd:

proc act_Select

*Feb 27 00:28:00.234:

*Feb 27 00:28:00.234: //209//TCL :/tcl_LegObjCmd: leg collectdigits leg_incoming param1

*Feb 27 00:28:00.234: //209//Digi:/tcl_LegDigitCollectObjCmd: collectdigits leg_incoming param1

*Feb 27 00:28:00.234: //209//AFW_:/vtd_lg_incoming: argc 3

*Feb 27 00:28:00.234: //209//AFW_:/vtd_lg_incoming: Legs [209 ]

*Feb 27 00:28:00.234: //209//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1

*Feb 27 00:28:00.234: //209//Digi:/C_DigitCollect_Start: Leg=209, Dialplan=True, Diaplanterm=True, DigitReport=False, DigitConsume=False IgnoreInitialKey=False, IgnoreDTMFacceptINFO=False, Abortkey=*, Terminationkey=#, Numpatterns=0, Maxdigits=0, Mindigits=0, Interruptprompt=True, InterTimeout=-1000, Initialtimeout=-1000, Mask=0 Hotword=0

*Feb 27 00:28:00.234: //-1//Digi:/AFW_DigitCollect_New:

*Feb 27 00:28:00.238: //-1//Digi:HN0462E1E4:/AFW_DigitCollect_New: DialPlan=TRUE AbortKey=* TermKey=# NumPatts=0

Enable=FALSE Consume=FALSE InterruptPrompt=TRUE minDigits=0 maxDigits=0 DialPlanTerm=TRUE hotword=0

*Feb 27 00:28:00.238: //-1//AFW_:LP:EE681ABEBC000:HN0462E1E4:/AFW_M_Object_SetExecEnv: ObjCount: 4, CmdPending 1

*Feb 27 00:28:00.238: //209//AFW_:/AFW_Object_AddListener: adding Module TclModule as listener

*Feb 27 00:28:00.238: //209//AFW_:/AFW_M_Module_GetHandle: Module handle: DigitCollect_696DA30C_0_73589220

*Feb 27 00:28:00.238: //209/9DE891800000/AFW_:/AFW_Object_AddListener: adding Module DigitCollect as listener

*Feb 27 00:28:00.238: //209/9DE891800000/Digi:/DigitCollectStart_UpdateStats:

*Feb 27 00:28:00.238: //209//Digi:/DigitCollect_MLPPTuning:

*Feb 27 00:28:00.238: //209//Digi:/DigitCollect_MLPPTuning: Precednece Digit Collect not enabled

*Feb 27 00:28:00.238: //209/9DE891800000/AFW_:/AFW_Leg_TypeAheadGet: no chars in buffer.

*Feb 27 00:28:00.238: //209/9DE891800000/CCAPI/ccSetDigitTimeouts:

Initial Digit Timeout=-1000(ms), Inter Digit Timeout=-1000(ms)

*Feb 27 00:28:00.238: //209/9DE891800000/CCAPI/ccSetDigitTimeouts:

Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=10000(ms))

*Feb 27 00:28:00.238: //209/9DE891800000/AFW_:/AFW_Leg_DigitReportEnable: Current: 0x0 Input: 0x2

*Feb 27 00:28:00.238: //209/9DE891800000/CCAPI/ccCallReportDigits:

(callID=0xD1, digit_event=0x1, enable=TRUE, consume=FALSE)

*Feb 27 00:28:00.238: //209/9DE891800000/CCAPI/ccCallReportDigits:

Enabled=TRUE, Call Id=209

*Feb 27 00:28:00.238: //209/9DE891800000/CCAPI/cc_api_call_report_digits_done:

(vdbPtr=0x68263008, callID=0xD1, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE)

*Feb 27 00:28:00.238: //209/9DE891800000/CCAPI/cc_api_call_report_digits_done:

Enabled=TRUE, Disposition=0x0, Interface=0x68263008, Call Id=209

*Feb 27 00:28:00.238: //209/9DE891800000/CCAPI/cc_api_call_report_digits_done:

Call Entry(Initial Digit Timeout=10000(ms), Inter Digit Timeout=10000(ms))

*Feb 27 00:28:00.238: //209//PACK:/tcl_MediaObjCmd: media play leg_incoming _dest_no_alcanzable.au %s500 _redest.au

*Feb 27 00:28:00.238: //209//PACK:/tcl_MediaPlayObjCmd: play leg_incoming _dest_no_alcanzable.au %s500 _redest.au

*Feb 27 00:28:00.242: //209//AFW_:/vtd_lg_incoming: argc 5

*Feb 27 00:28:00.242: //209//AFW_:/vtd_lg_incoming: Legs [209 ]

*Feb 27 00:28:00.242: //209//Tcl :/tcl_parseCallID_vartagObj: VARTAG Translation Leg Count=1

*Feb 27 00:28:00.242: //-1//DPM :DP134:/pc_mc_addToDynamicS: (3) _dest_no_alcanzable.au %s500 _redest.au

*Feb 27 00:28:00.242: //-1//DPM :DP134:/pc_mc_addToDynamicS: Doing : _dest_no_alcanzable.au

*Feb 27 00:28:00.242: //-1//DPM :/mcTokenizerGetNext: savedcharptr=_ endptrptr=_dest_no_alcanzable.au

*Feb 27 00:28:00.242: //-1//DPM :DP134:/pc_mc_addToDynamicS: Token : _dest_no_alcanzable.au status 1

*Feb 27 00:28:00.242: //-1//DPM :DP134:/pc_mc_addToDynamicS: call dp_mcDQfromFileDynamic() to Handle relative file name

*Feb 27 00:28:00.242: //-1//DPM :DP134:/dp_mcDQfromFileDynamic: pLanguage=en FileName=_dest_no_alcanzable.au

*Feb 27 00:28:00.242: //-1//DPM :DP134:/dp_mcDQfromURL: file=flash:en_dest_no_alcanzable.au

*Feb 27 00:28:00.242: //-1//MCM :/mc_createFromFileUrl: Getting a media content: name=en_dest_no_alcanzable.au

url=flash:en_dest_no_alcanzable.au

load fast, fetchtimeout=-1

*Feb 27 00:28:00.242: //-1//MCM :MC11:/mc_getFromUrlName: en_dest_no_alcanzable.au on ram

*Feb 27 00:28:00.242: //-1//MCM :/mc_createFromFileUrl: Found a good mc (0x6973E964), RefCount(1)

*Feb 27 00:28:00.242: //-1//DPM :DP134:/dp_mcDQfromURL: mc_createFromFileUrl OK

*Feb 27 00:28:00.242: //-1//DPM :/mcTokenizerGetNext: savedcharptr= endptrptr=

*Feb 27 00:28:00.242: //-1//DPM :DP134:/pc_mc_addToDynamicS: Doing : %s500

*Feb 27 00:28:00.242: //-1//DPM :/mcTokenizerGetNext: savedcharptr=% endptrptr=%s500

*Feb 27 00:28:00.242: //-1//DPM :DP134:/pc_mc_addToDynamicS: Token : %s500 status 1

*Feb 27 00:28:00.242: //-1//DPM :DP134:/dp_mcDQfromSilence: time=500

*Feb 27 00:28:00.242: //-1//DPM :/du_create_silenceDynamicObj: silence=500

*Feb 27 00:28:00.242: //-1//DPM :/du_create_silenceUrlName: name=silence:500

*Feb 27 00:28:00.246: //-1//DPM :/mcTokenizerGetNext: savedcharptr= endptrptr=

*Feb 27 00:28:00.246: //-1//DPM :DP134:/pc_mc_addToDynamicS: Doing : _redest.au

*Feb 27 00:28:00.246: //-1//DPM :/mcTokenizerGetNext: savedcharptr=_ endptrptr=_redest.au

*Feb 27 00:28:00.246: //-1//DPM :DP134:/pc_mc_addToDynamicS: Token : _redest.au status 1

*Feb 27 00:28:00.246: //-1//DPM :DP134:/pc_mc_addToDynamicS: call dp_mcDQfromFileDynamic() to Handle relative file name

*Feb 27 00:28:00.246: //-1//DPM :DP134:/dp_mcDQfromFileDynamic: pLanguage=en FileName=_redest.au

*Feb 27 00:28:00.246: //-1//DPM :DP134:/dp_mcDQfromURL: file=flash:en_redest.au

*Feb 27 00:28:00.246: //-1//MCM :/mc_createFromFileUrl: Getting a media content: name=en_redest.au

url=flash:en_redest.au

load fast, fetchtimeout=-1

*Feb 27 00:28:00.246: //-1//MCM :MC13:/mc_getFromUrlName: en_redest.au on ram

*Feb 27 00:28:00.246: //-1//MCM :/mc_createFromFileUrl: Found a good mc (0x6A1BB1F8), RefCount(1)

*Feb 27 00:28:00.246: //-1//DPM :DP134:/dp_mcDQfromURL: mc_createFromFileUrl OK

*Feb 27 00:28:00.246: //-1//DPM :/mcTokenizerGetNext: savedcharptr= endptrptr=

*Feb 27 00:28:00.246: //209//PACK:/Media_Play_Start:

*Feb 27 00:28:00.246: //209//MSW :/msw_synth_get_stream_state: genericStream 0x6847C1B8 is in state MSW_S_IDLE

*Feb 27 00:28:00.246: //-1//MSW :/msw_synth_start:

*Feb 27 00:28:00.246: msw_synth_start: Enter...

*Feb 27 00:28:00.246: //209//MSW :/msw_synth_start: current_stream_id=4, content 0x0, dynamicS 0x6A4236A0, current_state=MSW_S_IDLE

*Feb 27 00:28:00.246: //-1//MSW :/msw_synth_start: msw_synth_start: p_mcDynamicS, We've been given a list of URLs to play.

*Feb 27 00:28:00.246: //-1//MSW :/msw_synth_start: p_mcDynamicQ is NOT empty

*Feb 27 00:28:00.246: //209//MSW :/msu_synth_partial_play: Media Stream URL

*Feb 27 00:28:00.246: //209/9DE891800000/CCAPI/ccAssociateStream:

Coder=5, DTMF Relay=1, Vad=0,

Record Function=0x0, Event Queue=0x68BC8FA8, Stream Context=69619FD4,

Record Context=0x0, Stream Call Id=210, Call Id=209

*Feb 27 00:28:00.246: //209/9DE891800000/CCAPI/ccAssociateStream:

Call Entry(Stream Status=2, Digit Enable=TRUE)

*Feb 27 00:28:00.246: //209//TCL :/tcl_FSMObjCmd: fsm setstate GETDEST

*Feb 27 00:28:00.250: //209//TCL :/tcl_FSMSetStateObjCmd: setstate setstate GETDEST

*Feb 27 00:28:00.250: //209//AFW_:/AFW_FSM_Drive: ACTION END: -------------(GETDEST[3])---------------

*Feb 27 00:28:00.250: //209//AFW_:/AFW_ExecEnv_SetModuleScope: TclModule_6A43B178_0_73558128 ---> NULL

*Feb 27 00:28:00.250: //209//AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:28:00.250: //209//AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:28:00.250: //209//AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:28:00.250: //209//AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:00.250: //209//AFW_:/AFW_M_Event_Free: MODULEDONEEVENT for a Module: DigitCollect_696DA084_0_73576372

*Feb 27 00:28:00.250: //209//AFW_:/AFW_Object_RemoveAllListener:

*Feb 27 00:28:00.250: //-1//AFW_:/AFW_M_Object_UnSetExecEnv: ObjCount: 3, CmdPending 1

*Feb 27 00:28:00.250: //-1//AFW_:HN0462AFB4:/AFW_M_Event_Free: ExecEnv objCount: 3

*Feb 27 00:28:00.250: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:28:00.250: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:28:00.250: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:28:00.250: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_REPORT_DIGITS_DONE(68)] {

*Feb 27 00:28:00.250: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:28:00.250: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.250: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:28:00.250: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:28:00.250: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:28:00.254: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:28:00.254: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA30C_0_73589220] (

*Feb 27 00:28:00.254: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.254: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:00.254: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:28:00.254: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA30C_0_73589220] (

*Feb 27 00:28:00.254: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.254: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:00.254: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:00.254: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:00.254: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:28:00.254: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect

*Feb 27 00:28:00.254: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_696DA30C_0_73589220

*Feb 27 00:28:00.254: //209//Digi:/AFW_M_DigitCollect_Action:

*Feb 27 00:28:00.254: //209//Digi:/act_DCRunning_RDone: id=209 Enable succeeded.enable=0 matchDialplan=1 numPatterns=0matchDialplanTerm=1

*Feb 27 00:28:00.254: //209//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_696DA30C_0_73589220 ---> NULL

*Feb 27 00:28:00.254: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:00.254: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:28:00.258: //209/9DE891800000/CCAPI/cc_api_call_associated:

Interface=0x0, CallId=209, Disposition=0

Play Function=0x63D162C4, Codec=0x5, Vad=0x0

Media Type=0x3, SPI Context=0x696D6F40, Stream CallId=210

TX Dynamic Pt=0x0, RX Dynamic Pt=0x0

*Feb 27 00:28:00.258: //209//MSM :LP:MS105:/ms_associateDone:

*Feb 27 00:28:00.258: //209//MSM :/ms_asDone_buginf: callID=0xD1, pVdb=0x68263008,

disposition=0, playFunc=0x63D162C4,

codec=0x5=g711ulaw, vad=0,

mediaType=3, streamAssocID=210

*Feb 27 00:28:00.258: //-1//MCM :MR133:/mc_setup_reader_encaps: SSRC: 0xA0 SeqNum: 0x1A1A

*Feb 27 00:28:00.258: //209//MSM :/ms_associateDone: First Buf Play at 20:26:29.240 of en_dest_no_alcanzable.au

*Feb 27 00:28:00.258: //209//MSM :/ms_associateDone: 20:26:29.240, Tstart(ply: iSndDly 0)

*Feb 27 00:28:00.258: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:28:00.258: //-1//AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:00.258: //-1//AFW_:/AFW_M_Event_Free: Null or invalid event context: for event APP_EV_NULL

*Feb 27 00:28:00.262: //209//MSM :/ms_handle_stream_timer: >>ms_start_play()

*Feb 27 00:28:00.262: //209//MSM :/ms_start_play: 20:26:29.244 mgdTstop(ply)

*Feb 27 00:28:00.578: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:28:00.578: //-1//AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:00.578: //-1//AFW_:/AFW_M_Event_Free: Null or invalid event context: for event APP_EV_NULL

*Feb 27 00:28:00.578: //-1//AFW_:/AFW_Process_GetTimerEvent: Process Shutdown: 0x68AB84D8

*Feb 27 00:28:00.578: //-1/xxxxxxxxxxxx/CCAPI/ccAppShutdownMode:

ccAppShutdownMode: remove it from the queue

*Feb 27 00:28:03.818: //-1/xxxxxxxxxxxx/SIP/Error/ccsip_set_release_source_for_peer: Failed AV set

*Feb 27 00:28:03.822: //209/9DE891800000/CCAPI/cc_api_call_disconnected:

Cause Value=16, Interface=0x68263008, Call Id=209

*Feb 27 00:28:03.822: //209/9DE891800000/CCAPI/cc_api_call_disconnected:

Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)

*Feb 27 00:28:03.822: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:28:03.822: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:28:03.822: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DISCONNECTED(20)] {

*Feb 27 00:28:03.822: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:28:03.822: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCCONNECTED(5)][Cause(0)]

*Feb 27 00:28:03.822: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:28:03.822: //209/9DE891800000/SSIN:/AFW_SS_MapEvent:

*Feb 27 00:28:03.822: //-1//SSIN:/AFW_SS_SIP_MapEvent:

*Feb 27 00:28:03.822: //-1//MSW :/msw_synth_bargein:

*Feb 27 00:28:03.826: msw_synth_bargein: genericStream=0x6847C1B8,

reason=MSW_REASON_DISCONNECTED, current_state=MSW_S_PLAYING

*Feb 27 00:28:03.826: //-1//MSW :/msw_synth_stop: msw_synth_stop: Enter...

*Feb 27 00:28:03.826: //-1//MSW :/msw_synth_stop: genericStream=0x6847C1B8,

mediaStream=0x69619FD4, rtspStream=0x6847CC3C

reason=MSW_SYNTH_REASON_DISCONNECTED, current_state=MSW_S_PLAYING

*Feb 27 00:28:03.826: //209//MSW :/msw_synth_stop: msw_synth_stop: call ms_stop_play()...

*Feb 27 00:28:03.826: //209//MSM :/ms_stop_play: mgdTstop at 20:26:32.808 (cause MS_STOP_DISCONNECTED)

*Feb 27 00:28:03.826: //209//MSM :/ms_stop_play: Play Stopped at 20:26:32.808

*Feb 27 00:28:03.826: //209/9DE891800000/CCAPI/ccDisassociateStream:

Record Context=0x0, Stream Call Id=210, Call Id=209

*Feb 27 00:28:03.826: //209/9DE891800000/CCAPI/ccDisassociateStream:

Call Entry(Stream Status=1, Digit Enable=TRUE)

*Feb 27 00:28:03.826: //209//MSM :/ms_stop_play: calling CBF for stream_id 4

*Feb 27 00:28:03.826: //209//MSW :/msu_synth_ms_play_complete: context=0x6847C1BC, use_dynamic=1, dynamicElement=0x696DD0CC,

cause=MS_STOP_DISCONNECTED, stream_id=4, duration=3560, rate=0 proto_code=0

*Feb 27 00:28:03.826: //209//MSW :/msu_synth_ms_play_complete: Ignoring: cur. stream=5, resp. stream=4

*Feb 27 00:28:03.826: //209//MSW :/msw_synth_stop: msw_synth_stop: call reg_invoke_dp_delete_mcDynamicS()

*Feb 27 00:28:03.826: //-1//MCM :MC11:/mc_delete: mc=0x6973E964

*Feb 27 00:28:03.826: //-1//MCM :MC11:/mc_check_background_load: mc(0x6973E964), mc->eof=1

*Feb 27 00:28:03.826: //-1//MCM :MC137:/mc_delete: mc=0x6A2A8C24

*Feb 27 00:28:03.830: //-1//MCM :MC137:/mc_check_background_load: mc(0x6A2A8C24), mc->eof=1

*Feb 27 00:28:03.830: //-1//MCM :MC137:/mc_remove: mc: 0x6A2A8C24

*Feb 27 00:28:03.830: //-1//MCM :MC137:/mc_hold_mc: mc_hold_mc: 0x6A2A8C24

*Feb 27 00:28:03.830: //-1//MCM :MC13:/mc_delete: mc=0x6A1BB1F8

*Feb 27 00:28:03.830: //-1//MCM :MC13:/mc_check_background_load: mc(0x6A1BB1F8), mc->eof=1

*Feb 27 00:28:03.830: //209/9DE891800000/AFW_:/AFW_Leg_MediaCallback:

*Feb 27 00:28:03.830: //-1//AFW_:/AFW_Leg_MediaCallback: pLeg=0x696BF2B8, pModule=0x6A43B178

*Feb 27 00:28:03.830: //-1//AFW_:/AFW_Event_New: Event ID: ev_media_done

*Feb 27 00:28:03.830: //-1//MSW :/msw_mediadone_stats:

*Feb 27 00:28:03.830: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:28:03.830: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:28:03.830: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA30C_0_73589220] (

*Feb 27 00:28:03.830: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(16)]

*Feb 27 00:28:03.830: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:03.830: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:28:03.830: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA30C_0_73589220] (

*Feb 27 00:28:03.834: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(16)]

*Feb 27 00:28:03.834: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:03.834: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(16)]

*Feb 27 00:28:03.834: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:03.834: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:28:03.834: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect

*Feb 27 00:28:03.834: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_696DA30C_0_73589220

*Feb 27 00:28:03.834: //209//Digi:/AFW_M_DigitCollect_Action:

*Feb 27 00:28:03.834: //209//Digi:/act_DCRunning_Disconnected:

*Feb 27 00:28:03.834: //-1//Digi:/DigitCollect_Complete: DC_DISCONNECTED. Digits=

*Feb 27 00:28:03.834: //209//Digi:/DigitCollect_MLPPPostAdjust: Non MLPP call

*Feb 27 00:28:03.834: //-1//AFW_:/AFW_Event_New: Event ID: ev_collectdigits_done

*Feb 27 00:28:03.834: //209//AFW_:/AFW_Module_ReturnArgEv:

*Feb 27 00:28:03.834: //209//AFW_:/AFW_Module_ReturnArgEv: Return List (remove=TRUE){LEG[209 ][LEG_INCCONNECTED(5)][Cause(16)]}

*Feb 27 00:28:03.834: //209/9DE891800000/AFW_:/AFW_Object_RemoveListener:

*Feb 27 00:28:03.834: //209//AFW_:/AFW_Module_UnListen: NumObjects: 0

*Feb 27 00:28:03.834: //209//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_696DA30C_0_73589220 ---> NULL

*Feb 27 00:28:03.834: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : TclModule

*Feb 27 00:28:03.834: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> TclModule_6A43B178_0_73558128

*Feb 27 00:28:03.834: //209//AFW_:/AFW_M_TclModule_Action:

*Feb 27 00:28:03.834: //209//AFW_:/AFW_TclModule_DefaultEvHandling:

*Feb 27 00:28:03.834: //209//AFW_:/AFW_FSM_Drive: ACTION BEGIN: ------(GETDEST[3],ev_disconnected[20])---[act_Cleanup]------

*Feb 27 00:28:03.838: //209//TCL :/tcl_CallObjCmd: call close

*Feb 27 00:28:03.838: //209//TCL :/tcl_CallCloseObjCmd: close

*Feb 27 00:28:03.838: //-1//AFW_:/AFW_ExecEnv_CallClose: Exec Env state: 1

*Feb 27 00:28:03.838: //-1//AFW_:/AFW_ExecEnv_CallClose: Terminating ExecEnv's root module

*Feb 27 00:28:03.838: //209//AFW_:/AFW_Module_Terminate: Terminating Module: TclModule_6A43B178_0_73558128

*Feb 27 00:28:03.838: //209//AFW_:/AFW_M_TclModule_Terminate: Module is in the state: ACTIVE

*Feb 27 00:28:03.838: //209//AFW_:/AFW_Module_Terminate: Terminating Module: DigitCollect_696DA30C_0_73589220

*Feb 27 00:28:03.838: //209//AFW_:/AFW_FSM_Drive: ACTION END: -------------(GETDEST[3])---------------

*Feb 27 00:28:03.838: //209//AFW_:/AFW_ExecEnv_SetModuleScope: TclModule_6A43B178_0_73558128 ---> NULL

*Feb 27 00:28:03.838: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:03.838: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:28:03.838: //209//AFW_:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED

*Feb 27 00:28:03.838: //209//AFW_:/AFW_Process_GetPriorityQEvent: Received

*Feb 27 00:28:03.838: //-1//AFW_:/AFW_Process_GetPriorityQEvent: Event[APP_EV_DIGITCOLLECT_DONE(228)] {

*Feb 27 00:28:03.838: //-1//AFW_:/AFW_Process_GetPriorityQEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:28:03.838: //-1//AFW_:/AFW_Process_GetPriorityQEvent: MOD[DigitCollect_696DA30C_0_73589220] (

*Feb 27 00:28:03.838: //-1//AFW_:/AFW_Process_GetPriorityQEvent: )

*Feb 27 00:28:03.838: //-1//AFW_:/AFW_Process_GetPriorityQEvent: }

*Feb 27 00:28:03.838: //209//Digi:/AFW_M_DigitCollect_EventPreProcess:

*Feb 27 00:28:03.838: //209//Digi:/DigitCollectEnd_UpdateStats:

*Feb 27 00:28:03.838: //209//AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:28:03.838: //209//AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:28:03.838: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:28:03.842: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_696DA30C_0_73589220] (

*Feb 27 00:28:03.842: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:03.842: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_INCCONNECTED(5)][Cause(16)]

*Feb 27 00:28:03.842: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:03.842: //209//AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:28:03.842: //209//AFW_:/AFW_Object_WalkListeners: Entering Module : TclModule

*Feb 27 00:28:03.842: //209/9DE891800000/AFW_:/AFW_Object_AddListener: adding Module TclModule as listener

*Feb 27 00:28:03.842: //209//AFW_:/AFW_Object_RemoveListener:

*Feb 27 00:28:03.842: //209//AFW_:/AFW_Module_UnListen: NumObjects: 1

*Feb 27 00:28:03.842: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> TclModule_6A43B178_0_73558128

*Feb 27 00:28:03.842: //209//AFW_:/AFW_M_TclModule_Action:

*Feb 27 00:28:03.842: //209//AFW_:/AFW_M_TclModule_Action: Module is Terminating

*Feb 27 00:28:03.842: //209//AFW_:/AFW_TclModule_Cleaner: lastFailureCause 0

*Feb 27 00:28:03.842: //209/9DE891800000/AFW_:/AFW_Leg_Disconnect: Disconnecting Leg: LEG_209

*Feb 27 00:28:03.842: //209/9DE891800000/AFW_:/AFW_Leg_Disconnect: Disconnecting Leg: LEG_209, Cause 16

*Feb 27 00:28:03.842: //209/9DE891800000/AFW_:/AFW_Leg_UpdateStats: Updating stats for ID 3A type 2

*Feb 27 00:28:03.842: //209/9DE891800000/CCAPI/ccCallDisconnect:

Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)

*Feb 27 00:28:03.842: //209/9DE891800000/CCAPI/ccCallDisconnect:

Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)

*Feb 27 00:28:03.842: //209//AFW_:/AFW_ExecEnv_SetModuleScope: TclModule_6A43B178_0_73558128 ---> NULL

*Feb 27 00:28:03.842: //209//AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:28:03.842: //209//AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:28:03.842: //209//AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:28:03.842: //209//AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:03.846: //209//AFW_:/AFW_M_Event_Free: MODULEDONEEVENT for a Module: DigitCollect_696DA30C_0_73589220

*Feb 27 00:28:03.846: //209//AFW_:/AFW_Object_RemoveAllListener:

*Feb 27 00:28:03.846: //-1//AFW_:/AFW_M_Object_UnSetExecEnv: ObjCount: 2, CmdPending 1

*Feb 27 00:28:03.846: //-1//AFW_:HN0462E1E4:/AFW_M_Event_Free: ExecEnv objCount: 2

*Feb 27 00:28:03.846: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:28:03.846: //209//AFW_:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED

*Feb 27 00:28:03.846: //209//AFW_:/AFW_Process_GetAppQEvent: Received

*Feb 27 00:28:03.846: //-1//AFW_:/AFW_Process_GetAppQEvent: Event[MSW_EV_SYNTHESIZER(178)] {

*Feb 27 00:28:03.846: //-1//AFW_:/AFW_Process_GetAppQEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:28:03.846: //-1//AFW_:/AFW_Process_GetAppQEvent: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:28:03.846: //-1//AFW_:/AFW_Process_GetAppQEvent: LEG[209][LEG_INCDISCONNECTING(6)][Cause(16)]

*Feb 27 00:28:03.846: //-1//AFW_:/AFW_Process_GetAppQEvent: )

*Feb 27 00:28:03.846: //-1//AFW_:/AFW_Process_GetAppQEvent: }

*Feb 27 00:28:03.846: //209//AFW_:/AFW_M_TclModule_EventPreProcess:

*Feb 27 00:28:03.846: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> TclModule_6A43B178_0_73558128

*Feb 27 00:28:03.846: //209//AFW_:/AFW_M_TclModule_Action:

*Feb 27 00:28:03.846: //209//AFW_:/AFW_M_TclModule_Action: Module is Terminating

*Feb 27 00:28:03.846: //209//AFW_:/AFW_ExecEnv_SetModuleScope: TclModule_6A43B178_0_73558128 ---> NULL

*Feb 27 00:28:03.846: //209//AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:03.846: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

*Feb 27 00:28:03.846: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:28:03.846: //-1//AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:03.846: //-1//AFW_:/AFW_M_Event_Free: Null or invalid event context: for event APP_EV_NULL

*Feb 27 00:28:03.850: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:28:03.850: //-1//AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:03.850: //-1//AFW_:/AFW_M_Event_Free: Null or invalid event context: for event APP_EV_NULL

*Feb 27 00:28:03.850: //209/9DE891800000/CCAPI/cc_api_call_disconnect_done:

Disposition=0, Interface=0x68263008, Tag=0x0, Call Id=209,

Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)

*Feb 27 00:28:03.850: //209/9DE891800000/CCAPI/cc_api_call_disconnect_done:

Call Disconnect Event Sent

*Feb 27 00:28:03.854: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Feb 27 00:28:03.854: :cc_free_feature_vsa freeing 6719C918

*Feb 27 00:28:03.854: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Feb 27 00:28:03.854: vsacount in free is 0

*Feb 27 00:28:03.854: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:28:03.854: //209/9DE891800000/AFW_:/AFW_Process_GetCcqEvent: Received

*Feb 27 00:28:03.854: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DISCONNECT_DONE(21)] {

*Feb 27 00:28:03.854: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:28:03.858: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[209][LEG_INCDISCONNECTING(6)][Cause(16)]

*Feb 27 00:28:03.858: //-1//AFW_:/AFW_Process_GetCcqEvent: }

*Feb 27 00:28:03.858: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

*Feb 27 00:28:03.858: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:28:03.858: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:28:03.858: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:28:03.858: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[209][LEG_DISCONNECTED(12)][Cause(16)]

*Feb 27 00:28:03.858: //-1//AFW_:/AFW_M_Object_ShowListeners: )

*Feb 27 00:28:03.858: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:28:03.858: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners: Entering Module : TclModule

*Feb 27 00:28:03.858: //209/9DE891800000/AFW_:/AFW_Object_RemoveListener:

*Feb 27 00:28:03.858: //209//AFW_:/AFW_Module_UnListen: NumObjects: 0

*Feb 27 00:28:03.858: //209//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> TclModule_6A43B178_0_73558128

*Feb 27 00:28:03.858: //209//AFW_:/AFW_M_TclModule_Action:

*Feb 27 00:28:03.858: //209//AFW_:/AFW_M_TclModule_Action: Module is Terminating

*Feb 27 00:28:03.858: //-1//AFW_:/AFW_Event_New: Event ID: ev_module_done

*Feb 27 00:28:03.858: //209//AFW_:/AFW_TclModule_ReturnIfDone: Sending Out APP_EV_TCLMODULE_DONE event

*Feb 27 00:28:03.858: //209//AFW_:/AFW_Module_ReturnArgEv:

*Feb 27 00:28:03.858: //209//AFW_:/AFW_ExecEnv_SetModuleScope: TclModule_6A43B178_0_73558128 ---> NULL

*Feb 27 00:28:03.858: //209/9DE891800000/AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:28:03.858: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:28:03.858: //209/9DE891800000/AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:28:03.858: //209/9DE891800000/AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:03.862: //209/9DE891800000/AFW_:/AFW_M_Event_Free: CC_EV_CALL_DISCONNECT_DONE for a Leg: LEG_209

*Feb 27 00:28:03.862: //209/9DE891800000/AFW_:/AFW_Object_RemoveAllListener:

*Feb 27 00:28:03.862: //209//AFW_:/AFW_ExecEnv_DecrNPendingCmd: PendingCmdCount: 0

*Feb 27 00:28:03.862: //-1//AFW_:/AFW_M_Object_UnSetExecEnv: ObjCount: 1, CmdPending 0

*Feb 27 00:28:03.862: //209/9DE891800000/AFW_:/AFW_M_Event_Free: ExecEnv objCount: 1

*Feb 27 00:28:03.862: //209/9DE891800000/AFW_:/AFW_M_Leg_Free:

*Feb 27 00:28:03.862: //209//MSW :/msw_destroy:

*Feb 27 00:28:03.862: //-1//MSW :/msw_stop: genericStream=0x6847C1B8,

reason=MSW_REASON_DISCONNECTED

*Feb 27 00:28:03.862: //-1//MSW :/msw_synth_stop: msw_synth_stop: Enter...

*Feb 27 00:28:03.862: //-1//MSW :/msw_synth_stop: genericStream=0x6847C1B8,

mediaStream=0x69619FD4, rtspStream=0x6847CC3C

reason=MSW_SYNTH_REASON_DISCONNECTED, current_state=MSW_S_IDLE

*Feb 27 00:28:03.862: //209//MSW :/msw_synth_stop: Stream not currently active

*Feb 27 00:28:03.862: //-1//MSW :/msw_recrd_stop: genericStream=0x6847C1B8,

mediaStream=0x6A295288, rtspStream=0x6847CC44

reason=MSW_RECRD_REASON_DISCONNECTED current_state=MSW_S_IDLE

*Feb 27 00:28:03.862: //-1//MSW :/msw_recrd_stop: Stream not currently active

*Feb 27 00:28:03.862: //-1//MSW :/msw_recog_stop:

*Feb 27 00:28:03.862: msw_recog_stop: genericStream=0x6847C1B8,

mrcpStream=0x6847CCC8

reason=MSW_RECOG_REASON_DISCONNECTED, current_state=MSW_S_IDLE

*Feb 27 00:28:03.862: //-1//MSW :/msw_synth_stop: msw_synth_stop: Enter...

*Feb 27 00:28:03.862: //-1//MSW :/msw_synth_stop: genericStream=0x6847C1B8,

mediaStream=0x69619FD4, rtspStream=0x6847CC3C

reason=MSW_SYNTH_REASON_DISCONNECTED, current_state=MSW_S_IDLE

*Feb 27 00:28:03.862: //209//MSW :/msw_synth_stop: Stream not currently active

*Feb 27 00:28:03.862: //209//MRCP:/mrcp_destroy_session:

sess_id=54, type=SYNTHESIZER, fsm context=0x6A2A9F68

*Feb 27 00:28:03.862: //-1//MRCP:/mrcp_get_ev:

****>Caller PC=0x636A8408, Count=201, Event=0x696F8B9C

*Feb 27 00:28:03.862: //-1//MSW :/msw_recrd_stop: genericStream=0x6847C1B8,

mediaStream=0x6A295288, rtspStream=0x6847CC44

reason=MSW_RECRD_REASON_DISCONNECTED current_state=MSW_S_IDLE

*Feb 27 00:28:03.862: //-1//MSW :/msw_recrd_stop: Stream not currently active

*Feb 27 00:28:03.862: //-1//MSW :/msw_recog_stop:

*Feb 27 00:28:03.862: msw_recog_stop: genericStream=0x6847C1B8,

mrcpStream=0x6847CCC8

reason=MSW_RECOG_REASON_DISCONNECTED, current_state=MSW_S_IDLE

*Feb 27 00:28:03.862: //209//MRCP:/mrcp_destroy_session:

sess_id=54, type=RECOGNIZER, fsm context=0x696DCF6C

*Feb 27 00:28:03.862: //-1//MRCP:/mrcp_get_ev:

****>Caller PC=0x636A8408, Count=202, Event=0x696F8BC4

*Feb 27 00:28:03.862: //209/9DE891800000/AFW_:/AFW_M_Leg_Free: LEG[209 ][LEG_DISCONNECTED(12)][Cause(16)]

*Feb 27 00:28:03.866: //209/9DE891800000/AFW_:/decrementDialPeerCallStats: Decrementing call-stat to [0], dial-peer [5555]

*Feb 27 00:28:03.866: //209//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 0

*Feb 27 00:28:03.866: //-1//AFW_:/AFW_ExecEnv_CallClose: Exec Env state: 3

*Feb 27 00:28:03.866: //209//AFW_:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED

*Feb 27 00:28:03.866: //209//AFW_:/AFW_Process_GetPriorityQEvent: Received

*Feb 27 00:28:03.866: //-1//AFW_:/AFW_Process_GetPriorityQEvent: Event[APP_EV_TCLMODULE_DONE(238)] {

*Feb 27 00:28:03.866: //-1//AFW_:/AFW_Process_GetPriorityQEvent: EXECENV[0x681ABEBC][pfp]

*Feb 27 00:28:03.866: //-1//AFW_:/AFW_Process_GetPriorityQEvent: MOD[TclModule_6A43B178_0_73558128] (

*Feb 27 00:28:03.866: //-1//AFW_:/AFW_Process_GetPriorityQEvent: )

*Feb 27 00:28:03.866: //-1//AFW_:/AFW_Process_GetPriorityQEvent: }

*Feb 27 00:28:03.866: //209//AFW_:/AFW_M_TclModule_EventPreProcess:

*Feb 27 00:28:03.866: //209//AFW_:/AFW_Object_WalkListeners:

*Feb 27 00:28:03.866: //209//AFW_:/AFW_M_Object_ShowListeners: START

*Feb 27 00:28:03.866: //209//AFW_:/AFW_M_Object_ShowListeners: END

*Feb 27 00:28:03.866: //209//AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:03.866: //209//AFW_:/AFW_M_Event_Free: MODULEDONEEVENT for a Module: TclModule_6A43B178_0_73558128

*Feb 27 00:28:03.866: //209//AFW_:/AFW_Object_RemoveAllListener:

*Feb 27 00:28:03.866: //-1//AFW_:/AFW_M_Object_UnSetExecEnv: ObjCount: 0, CmdPending 0

*Feb 27 00:28:03.866: //-1//AFW_:HN04626870:/AFW_M_Event_Free: ExecEnv objCount: 0

*Feb 27 00:28:03.866: //-1//SERV:/AFW_Service_ReleaseExecEnv: Script Name = pfp cache = true calls = 0

*Feb 27 00:28:03.866: //209//AFW_:/AFW_ExecEnv_UnSetRoot: Execenv = 0x681ABEBC

*Feb 27 00:28:03.866: //-1//AFW_:/AFW_Process_UnLock: pProcess(0x68AB8558)=0

*Feb 27 00:28:03.870: //-1//SCRI:/cam_sa_stopped: Instance: [] ExecEnv: 0x681ABEBC

*Feb 27 00:28:03.870: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

*Feb 27 00:28:03.870: //-1//AFW_:/AFW_M_Event_Free:

*Feb 27 00:28:03.870: //-1//AFW_:/AFW_M_Event_Free: Null or invalid event context: for event APP_EV_NULL

*Feb 27 00:28:03.870: //209//MRCP:/mrcp_process_events:

event: SYNTH_LIB_DESTROY SYNTHESIZER

*Feb 27 00:28:03.870: //209//MRCP:/mrcp_fsm_execute:

(0x6A2A9F68) type=SYNTHESIZER curr[SYNTH_IDLE]

*Feb 27 00:28:03.870: //209//MRCP:/mrcp_fsm_execute:

ev-id[SYNTH_LIB_DESTROY]

next[SYNTH_IDLE] action=636B4BDC0

*Feb 27 00:28:03.870: //209//MRCP:/act_synth_libdestroy:

*Feb 27 00:28:03.870: //209//MRCP:/mrcp_free_fsm:

*Feb 27 00:28:03.870: //209//MRCP:/mrcp_disconnect_connect_fsm:

(0x6A3A8AFC)

*Feb 27 00:28:03.870: //-1//MRCP:/mrcp_get_ev:

****>Caller PC=0x636AFC38, Count=203, Event=0x696F8BEC

*Feb 27 00:28:03.870: //-1//MRCP:/mrcp_free_ev:

---------------->Caller PC=0x636AB1E4, Count=201, Event=0x696F8B9C

*Feb 27 00:28:03.870: //209//MRCP:/mrcp_process_events:

event: RECOG_LIB_DESTROY RECOGNIZER

*Feb 27 00:28:03.870: //209//MRCP:/mrcp_fsm_execute:

(0x696DCF6C) type=RECOGNIZER curr[RECOG_IDLE]

*Feb 27 00:28:03.870: //209//MRCP:/mrcp_fsm_execute:

ev-id[RECOG_LIB_DESTROY]

next[RECOG_IDLE] action=636B34380

*Feb 27 00:28:03.870: //209//MRCP:/act_recog_libdestroy:

*Feb 27 00:28:03.870: //209//MRCP:/mrcp_free_fsm:

*Feb 27 00:28:03.870: //209//MRCP:/mrcp_disconnect_connect_fsm:

(0x6719E160)

*Feb 27 00:28:03.870: //-1//MRCP:/mrcp_get_ev:

****>Caller PC=0x636AFC38, Count=204, Event=0x696F8C14

*Feb 27 00:28:03.870: //-1//MRCP:/mrcp_free_ev:

---------------->Caller PC=0x636AB1E4, Count=202, Event=0x696F8BC4

*Feb 27 00:28:03.874: //209//MRCP:/mrcp_process_events:

event: LIB_DISCONNECT RESOURCE_NONE

*Feb 27 00:28:03.874: //209//MRCP:/mrcp_fsm_execute:

(0x6A3A8AFC) type=SYNTHESIZER curr[CONNECT_IDLE]

*Feb 27 00:28:03.874: //209//MRCP:/mrcp_fsm_execute:

ev-id[LIB_DISCONNECT]

next[CONNECT_IDLE] action=636B28040

*Feb 27 00:28:03.874: //209//MRCP:/act_idle_disconnect:

*Feb 27 00:28:03.874: //209//MRCP:/mrcp_cleanup_connect_fsm:

connect_fsm(0x6A3A8AFC)

*Feb 27 00:28:03.874: //209//MRCP:/hash_get:

Table=serverstatus_table, Key=42

*Feb 27 00:28:03.874: //-1//MRCP:/mrcp_free_ev:

---------------->Caller PC=0x636AB1E4, Count=203, Event=0x696F8BEC

*Feb 27 00:28:03.874: //209//MRCP:/mrcp_process_events:

event: LIB_DISCONNECT RESOURCE_NONE

*Feb 27 00:28:03.874: //209//MRCP:/mrcp_fsm_execute:

(0x6719E160) type=RECOGNIZER curr[CONNECT_IDLE]

*Feb 27 00:28:03.874: //209//MRCP:/mrcp_fsm_execute:

ev-id[LIB_DISCONNECT]

next[CONNECT_IDLE] action=636B28040

*Feb 27 00:28:03.874: //209//MRCP:/act_idle_disconnect:

*Feb 27 00:28:03.874: //209//MRCP:/mrcp_cleanup_connect_fsm:

connect_fsm(0x6719E160)

*Feb 27 00:28:03.874: //209//MRCP:/hash_get:

Table=serverstatus_table, Key=42

*Feb 27 00:28:03.874: //209//MRCP:/mrcp_free_scb:

scb=0x6973DEAC

*Feb 27 00:28:03.874: //209//MRCP:/mrcp_create_session_history:

scb=0x6973DEAC stream=0x0

*Feb 27 00:28:03.874: //209//MRCP:/mrcp_create_session_history:

No streams in session control block

*Feb 27 00:28:03.874: //-1//MRCP:/mrcp_free_ev:

---------------->Caller PC=0x636AB1E4, Count=204, Event=0x696F8C14

Re: TCL example its-CISCO issue

Raghavendra G V — Mon, 29 Feb 2016 03:54:16 GMT

Since Dialplan is set to true, digits collected based on your dial plan.
set param1(dialPlan) true

As Yawming suggested you can remove dialplan and try to set maxdigits or patterns based on your requirements.

    set param1(interruptPrompt) true
    set param1(maxDigits) 13
    set param1(initialDigitTimeout) 5
    set param1(terminationKey) #

leg collectdigits leg_incoming param1

    set pattern(1) "99....."
    set pattern(2) "88....."
    leg collectdigits leg_incoming param1 pattern

leg collectdigits param1

Note : You will get different status code cd_005 "The digit collection succeeded with a match to one of the patterns" instead of cd_004 status code.

For more information please refer TCL IVR programming Guide in below location.
https://developer.cisco.com/site/voice-gateway/documents/api-documents/index.gsp

Thanks,
Raghavendra

Re: TCL example its-CISCO issue

jvazquez — Tue, 01 Mar 2016 19:03:10 GMT

Thanks that is ..