1 2 First Previous 17 Replies Latest reply on Mar 1, 2016 7:03 PM by jvazquez@mnet.com.mx

    TCL example its-CISCO issue

    jvazquez@mnet.com.mx

      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.555: //-1//AFW_:/AFW_Util_CopyMLPPDataToCallInfoContainer: Voice MLPP not configured

      *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

        • 1. Re: TCL example its-CISCO issue
          yawchen

          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 !

          • 2. Re: TCL example its-CISCO issue
            jvazquez@mnet.com.mx

            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

            #

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

            # Copyright (c) 2001 by cisco Systems, Inc.

            # All rights reserved.

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

            #        

            # 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: //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: //-1//Dest:/AFW_Destination_New: 

            *Feb 25 20:46:54.511: //-1//AFW_:/AFW_FSM_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: //-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.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: //-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])

            • 3. Re: TCL example its-CISCO issue
              yawchen

              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.

              • 4. Re: TCL example its-CISCO issue
                jvazquez@mnet.com.mx

                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

                1 of 1 people found this helpful
                • 5. Re: TCL example its-CISCO issue
                  yawchen

                  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"

                  • 6. Re: TCL example its-CISCO issue
                    jvazquez@mnet.com.mx

                    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

                    • 7. Re: TCL example its-CISCO issue
                      yawchen

                      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.

                      • 8. Re: TCL example its-CISCO issue
                        jvazquez@mnet.com.mx

                        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:

                        • 9. Re: TCL example its-CISCO issue
                          yawchen

                            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

                          • 10. Re: TCL example its-CISCO issue
                            jvazquez@mnet.com.mx

                            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"    

                            • 11. Re: TCL example its-CISCO issue
                              yawchen

                              you may need to reload the service after adding new param

                              • 12. Re: TCL example its-CISCO issue
                                jvazquez@mnet.com.mx

                                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]

                                • 13. Re: TCL example its-CISCO issue
                                  yawchen

                                  Can you please attach debug ?

                                  • 14. Re: TCL example its-CISCO issue
                                    yawchen

                                    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

                                    1 2 First Previous