Code User Access Verification Username: pyramid Password: Router#debug voip application all All application debugging is on This may severely impact network performance due to the large number of debugs enabled. It should be used only during low traffic periods and no console logging. voip application error debugging is on Router#no debug voip application media Warning: This command has been replaced by 'no debug voip application media fork ing' voip application media forking debugging is off Warning: This command has been replaced by 'no debug voip application media pack et' voip application media packet debugging is off Warning: This command has been replaced by 'no debug voip application media stat e' voip application media state debugging is off Warning: This command has been replaced by 'no debug voip application media nego tiation' voip application medianeg debugging is off Router#debug voip dialpeer voip dialpeer default debugging is on Router#debug voice ccapi inout voip ccapi inout debugging is on Router# Router# Router# Router#ter Router#terminal mon Router#terminal monitor Router# Mar 12 11:06:16.512: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore: Calling Number=3, Called Number=3, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:16.512: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore: Match Rule=DP_MATCH_DEST; Called Number=3 Mar 12 11:06:16.512: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore: No Outgoing Dial-peer Is Matched; Result=NO_MATCH(-1) Mar 12 11:06:16.512: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=3, saf_enabled=1, saf_dndb_lookup=1, dp_result=-1 Mar 12 11:06:16.512: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg: Result=NO_MATCH(-1) Mar 12 11:06:16.512: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Calling Number=101, Called Number=, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:16.512: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=40003 Mar 12 11:06:16.512: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0 Mar 12 11:06:16.512: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Calling Number=101, Called Number=, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:16.512: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=40003 Mar 12 11:06:16.512: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0 Mar 12 11:06:16.512: //-1/3816AF398074/DPM/dpAssociateIncomingPeerCore: Calling Number=101, Called Number=3, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:16.512: //-1/3816AF398074/DPM/dpAssociateIncomingPeerCore: Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=40003 Mar 12 11:06:16.512: //-1/3816AF398074/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0 Mar 12 11:06:16.516: //-1/3816AF398074/CCAPI/cc_api_display_ie_subfields: cc_api_call_setup_ind_common: cisco-username=101 ----- ccCallInfo IE subfields ----- cisco-ani=101 cisco-anitype=0 cisco-aniplan=0 cisco-anipi=0 cisco-anisi=0 dest=3 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 Mar 12 11:06:16.516: //-1/3816AF398074/CCAPI/cc_api_call_setup_ind_common: Interface=0x224B4F54, Call Info( Calling Number=101,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Sc reened, Presentation=Allowed), Called Number=3(TON=Unknown, NPI=Unknown), Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=F ALSE, Incoming Dial-peer=40003, Progress Indication=NULL(0), Calling IE Present=TRU E, Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALS E), Call Id=54 Mar 12 11:06:16.516: //-1/3816AF398074/CCAPI/ccCheckClipClir: In: Calling Number=101(TON=Unknown, NPI=Unknown, Screening=Not Screened, Pres entation=Allowed) Mar 12 11:06:16.516: //-1/3816AF398074/CCAPI/ccCheckClipClir: Out: Calling Number=101(TON=Unknown, NPI=Unknown, Screening=Not Screened, Pre sentation=Allowed) Mar 12 11:06:16.516: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 12 11:06:16.516: :cc_get_feature_vsa malloc success Mar 12 11:06:16.516: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 12 11:06:16.516: cc_get_feature_vsa count is 1 Mar 12 11:06:16.516: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 12 11:06:16.516: :FEATURE_VSA attributes are: feature_name:0,feature_time:98 7259944,feature_id:30 Mar 12 11:06:16.516: //54/3816AF398074/CCAPI/cc_api_call_setup_ind_common: Set Up Event Sent; Call Info(Calling Number=101(TON=Unknown, NPI=Unknown, Screening=Not Screened , Presentation=Allowed), Called Number=3(TON=Unknown, NPI=Unknown)) Mar 12 11:06:16.516: //54/3816AF398074/CCAPI/cc_process_call_setup_ind: Event=0x22744068 Mar 12 11:06:16.516: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search: Try with the demoted called number 3 Mar 12 11:06:16.516: //-1//SERV:/AFW_Service_CCInterface: Received Event 27 for service Default modulehandle NULL Mar 12 11:06:16.516: //-1//SERV:/AFW_Service_GetExecEnv: Script Name = Default Mar 12 11:06:16.516: //-1//AFW_:/AFW_Process_New: Default Mar 12 11:06:16.516: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Process( Size=144) Mar 12 11:06:16.520: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x3D5A4824, Type: ProcManager, RefCount: 2 Mar 12 11:06:16.520: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x225CC630, Type: ExecEnv, RefCount: 1 Mar 12 11:06:16.520: //-1//SERV:/AFW_Service_GetExecEnv: Using Cached ExecEnv Mar 12 11:06:16.520: //-1//AFW_:EE225CC630000:/AFW_ExecEnv_SetRoot: Execenv = 0x 225CC630 Mar 12 11:06:16.520: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: TclModul e(Size=376) Mar 12 11:06:16.520: //-1//AFW_:/AFW_M_TclModule_NewDup: Mar 12 11:06:16.520: //-1//AFW_:/AFW_DataArray_New: Mar 12 11:06:16.520: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataArra y(Size=80) Mar 12 11:06:16.520: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x3D5CCB38, Type: TclModule, RefCount: 0 Mar 12 11:06:16.520: //-1//AFW_:HN0143BED8:/AFW_M_TclModule_Free: Mar 12 11:06:16.520: //-1//AFW_:HN0143BED8:/AFW_M_Module_GetHandle: Module handl e: TclModule_0x3D5CCB38_0_21216984MOD[TclModule_0x3D5CCB38_0_21216984] ( ) Mar 12 11:06:16.520: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x3D638CF4, Type: DataArray, RefCount: 0 Mar 12 11:06:16.520: //-1//AFW_:/AFW_Process_Lock: pProcess(0x22BEB228)=1 Mar 12 11:06:16.520: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x22BEB228, Type: Process, RefCount: 2 Mar 12 11:06:16.520: //-1//AFW_:LP:EE225CC630000:HN01718328:/AFW_M_Object_SetExe cEnv: ObjCount: 1, CmdPending 0 Mar 12 11:06:16.520: //-1//AFW_:EE225CC630000:/AFW_ExecEnv_RestoreDataBackup: Re store DataArea from Script Mar 12 11:06:16.520: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataArra y(Size=80) Mar 12 11:06:16.520: //-1//AFW_:EE225CC630000:/AFW_ExecEnv_RestoreDataBackup: Re store TokenTable from Script Mar 12 11:06:16.520: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataArra y(Size=80) Mar 12 11:06:16.520: //-1//AFW_:EE225CC630000:/AFW_ExecEnv_Initiate: Execenv = 0 x225CC630 Mar 12 11:06:16.520: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x3D5CCE28, Type: TclModule, RefCount: 2 Mar 12 11:06:16.520: //-1//AFW_:EE225CC630000:/AFW_ExecEnv_SetCallCorID: Mar 12 11:06:16.520: CallCorID is 8/9%ht!-{Q Mar 12 11:06:16.520: //-1//AFW_:/AFW_Leg_New: Mar 12 11:06:16.520: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Leg(Size =5488) Mar 12 11:06:16.520: //54/3816AF398074/CCAPI/ccCallSetContext: Context=0x3E86C86C Mar 12 11:06:16.520: //54//AFW_:/AFW_M_Leg_SetExecEnv: Mar 12 11:06:16.520: //-1//AFW_:EE225CC630000:/AFW_ExecEnv_IncrPendingCmd: Pend ingCmdCount: 1 Mar 12 11:06:16.520: //-1//AFW_:LP:EE225CC630000:LG54:/AFW_M_Object_SetExecEnv: ObjCount: 2, CmdPending 1 Mar 12 11:06:16.520: //54//AFW_:/AFW_Object_AddListener: adding Module TclModule as listener Mar 12 11:06:16.520: //54//AFW_:/AFW_M_Leg_GetHandle: Leg handle: LEG_54 Mar 12 11:06:16.520: //-1//AFW_:/AFW_DataArray_ElementSet: Adding param: LEG_54, type: Leg Mar 12 11:06:16.520: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x3E86C86C, Type: Leg, RefCount: 2 Mar 12 11:06:16.520: //-1//AFW_:EE225CC630000:/AFW_ExecEnv_AssignCall: Execenv = 0x225CC630, Leg = 54, Peer_Tag = 40003 Mar 12 11:06:16.520: //-1//AFW_:/AFW_ExecEnv_AssignCall: Linking CLI params of dialPeer 40003 to ExecEnv Mar 12 11:06:16.520: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x22BBC700, Type: DataArray, RefCount: 4 Mar 12 11:06:16.520: //54//AFW_:/AFW_ExecEnv_SetCallCorID: Mar 12 11:06:16.520: CallCorID is 8/9%ht!-{Q Mar 12 11:06:16.520: //54/3816AF398074/CCAPI/cc_process_call_setup_ind: >>>>CCAPI handed cid 54 with tag 40003 to app "_ManagedAppProcess_Default" Mar 12 11:06:16.520: //-1//SERV:/AFW_Service_Process_Space: Mar 12 11:06:16.520: Process Started Mar 12 11:06:16.520: //-1//AFW_:/AFW_Process_Register: ccAppInitialize(name: _Ma nagedAppProcess_Default) Mar 12 11:06:16.520: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event(0) Mar 12 11:06:16.520: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Event(Si ze=2864) Mar 12 11:06:16.520: //-1//AFW_:/AFW_DataList_New: Mar 12 11:06:16.520: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataList (Size=40) Mar 12 11:06:16.520: //54//AFW_:/AFW_Process_GetCcqEvent: Received Mar 12 11:06:16.520: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_SET UP_IND(36)] { Mar 12 11:06:16.520: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x225CC630 ][Default] Mar 12 11:06:16.520: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[54][LEG_INIT(0 )][Cause(0)] Mar 12 11:06:16.520: //-1//AFW_:/AFW_Process_GetCcqEvent: } Mar 12 11:06:16.520: //54//SSIN:/AFW_SS_MapEvent: Mar 12 11:06:16.520: //-1//SSIN:/AFW_SS_SIP_MapEvent: Mar 12 11:06:16.520: //54/3816AF398074/AFW_:/AFW_Leg_UpdateStats: Updating stats for ID 13 type 0 Mar 12 11:06:16.520: //54/3816AF398074/AFW_:/incrementIncomingDialPeerCallStats: Incrementing call-stat to [1] for dial-peer [40003] Mar 12 11:06:16.520: //54/3816AF398074/AFW_:/AFW_Object_WalkListeners: Mar 12 11:06:16.520: //54/3816AF398074/AFW_:/AFW_M_Object_ShowListeners: START Mar 12 11:06:16.520: //-1//AFW_:/AFW_M_Object_ShowListeners: Mar 12 11:06:16.520: //54//AFW_:/AFW_M_Module_GetHandle: Module handle: TclModul e_0x3D5CCE28_0_24216360MOD[TclModule_0x3D5CCE28_0_24216360] ( Mar 12 11:06:16.520: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INC INIT(1)][Cause(0)] Mar 12 11:06:16.520: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.520: //54/3816AF398074/AFW_:/AFW_M_Object_ShowListeners: END Mar 12 11:06:16.520: //54/3816AF398074/AFW_:/AFW_Object_WalkListeners: Entering Module : TclModule Mar 12 11:06:16.520: //54//AFW_:/AFW_ExecEnv_SetModuleScope: TclModule_0x3D5CCE2 8_0_24216360 ---> TclModule_0x3D5CCE28_0_24216360 Mar 12 11:06:16.524: //54//AFW_:/AFW_M_TclModule_Action: Mar 12 11:06:16.524: //54//AFW_:/AFW_TclModule_DefaultEvHandling: Mar 12 11:06:16.524: //54/3816AF398074/AFW_:/AFW_Leg_CheckIncomingCallBlock: Mar 12 11:06:16.524: //54/3816AF398074/AFW_:/AFW_Leg_SettlementValidateCall: tar get=ipv4:192.168.1.16:5060, tokenp=0x0 Mar 12 11:06:16.524: //54/3816AF398074/AFW_:/AFW_Leg_IncomingTranslate: Mar 12 11:06:16.524: //-1//AFW_:/AFW_Leg_IncomingTranslate: Tag(40003) calling[1 01] redirect[] called[3] Mar 12 11:06:16.524: //-1//AFW_:/AFW_ExecEnv_CallProc: ::Service::handle_event Mar 12 11:06:16.524: //-1//AFW_:/C_ServiceSession_Event_Handler: Mar 12 11:06:16.524: //-1//AFW_:/AFW_ExecEnv_CallProc: XCCSession::AcceptCallChe ck Mar 12 11:06:16.524: //54//XCCS:/C_PackageXCCSession_AcceptCallCheck: No AcceptC all; XCC application is unregistered Mar 12 11:06:16.524: //-1//AFW_:/AFW_ExecEnv_CallProc: Session::NewCall Mar 12 11:06:16.524: //-1//AFW_:/AFW_Session_New: Mar 12 11:06:16.524: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Session( Size=688) Mar 12 11:06:16.524: //-1//AFW_:/AFW_DataArray_New: Mar 12 11:06:16.524: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataArra y(Size=80) Mar 12 11:06:16.524: //-1//AFW_:/AFW_FSM_New: Mar 12 11:06:16.524: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: FSM(Size =104) Mar 12 11:06:16.524: //-1//AFW_:HN0171832C:/AFW_M_Session_SetExecEnv: Mar 12 11:06:16.524: //-1//AFW_:LP:EE225CC630000:HN0171832C:/AFW_M_Object_SetExe cEnv: ObjCount: 3, CmdPending 1 Mar 12 11:06:16.524: //54//AFW_:/AFW_Object_AddListener: adding Module TclModule as listener Mar 12 11:06:16.524: //54//AFW_:/AFW_M_Module_GetHandle: Module handle: Session_ 0x232FDE58_0_24216364 Mar 12 11:06:16.524: //-1//AFW_:/AFW_DataArray_ElementSet: Adding param: Session _0x232FDE58_0_24216364, type: Session Mar 12 11:06:16.524: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x232FDE58, Type: Session, RefCount: 2 Mar 12 11:06:16.524: //54//AFW_:/C_PackageSession_NewCall: Session module listen ed by TclModule_0x3D5CCE28_0_24216360 Mar 12 11:06:16.524: //54//AFW_:/AFW_ExecEnv_SetModuleScope: TclModule_0x3D5CCE2 8_0_24216360 ---> Session_0x232FDE58_0_24216364 Mar 12 11:06:16.524: //54//AFW_:/AFW_FSM_Drive: ACTION BEGIN: ------(S_OPEN[1],e v_setup_indication[36])---[C_Action]------ Mar 12 11:06:16.524: //54//AFW_:/Open_SetupIndication: Calling #(101), Calling N ame (), Called #(3), peer_tag(40003) Mar 12 11:06:16.524: //-1//AFW_:/AFW_Util_GetCalledNumber: calledNumber = 3 Mar 12 11:06:16.524: //54/3816AF398074/AFW_:/AFW_Object_AddListener: adding Modu le Session as listener Mar 12 11:06:16.524: //-1//AFW_:/AFW_DataArray_ElementSet: Adding param: LEG_54, type: Leg Mar 12 11:06:16.524: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x3E86C86C, Type: Leg, RefCount: 3 Mar 12 11:06:16.524: //54/3816AF398074/CCAPI/ccCallSetupAck: Call Id=54 Mar 12 11:06:16.524: //54/3816AF398074/CCAPI/cc_api_set_transfer_info: Transfer Number=, Transfer Reason=0x0 Mar 12 11:06:16.524: //-1//AFW_:/AFW_ExecEnv_CallProc: DigitCollect::Start Mar 12 11:06:16.524: //54//Digi:/C_DigitCollect_Start: Leg=54, Dialplan=True, Di aplanterm=False, DigitReport=False, DigitConsume=False IgnoreInitialKey=False, I gnoreDTMFacceptINFO=True, Abortkey=, Terminationkey=#, Numpatterns=0, Maxdigits= 0, Mindigits=0, Interruptprompt=False, InterTimeout=-1000, Initialtimeout=-1000, Mask=0 Hotword=0 Mar 12 11:06:16.524: //-1//Digi:/AFW_DigitCollect_New: Mar 12 11:06:16.524: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DigitCol lect(Size=648) Mar 12 11:06:16.524: //-1//AFW_:/AFW_DataArray_New: Mar 12 11:06:16.524: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataArra y(Size=80) Mar 12 11:06:16.524: //-1//Digi:HN0171832C:/AFW_DigitCollect_New: DialPlan=TRUE AbortKey= TermKey=# NumPatts=0 Enable=FALSE Consume=FALSE InterruptPrompt=FALSE minDigits=0 maxDi gits=0 DialPlanTerm=FALSE hotword=0 Mar 12 11:06:16.524: //-1//AFW_:LP:EE225CC630000:HN0171832C:/AFW_M_Object_SetExe cEnv: ObjCount: 4, CmdPending 1 Mar 12 11:06:16.524: //54//AFW_:/AFW_Object_AddListener: adding Module Session a s listener Mar 12 11:06:16.524: //54//AFW_:/AFW_M_Module_GetHandle: Module handle: DigitCol lect_0x3E87A568_0_24216364 Mar 12 11:06:16.524: //-1//AFW_:/AFW_DataArray_ElementSet: Adding param: DigitCo llect_0x3E87A568_0_24216364, type: DigitCollect Mar 12 11:06:16.524: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x3E87A568, Type: DigitCollect, RefCount: 2 Mar 12 11:06:16.524: //54/3816AF398074/AFW_:/AFW_Object_AddListener: adding Modu le DigitCollect as listener Mar 12 11:06:16.524: //-1//AFW_:/AFW_DataArray_ElementSet: Adding param: LEG_54, type: Leg Mar 12 11:06:16.524: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x3E86C86C, Type: Leg, RefCount: 4 Mar 12 11:06:16.524: //54/3816AF398074/Digi:/DigitCollectStart_UpdateStats: Mar 12 11:06:16.524: //54//Digi:/DigitCollect_MLPPTuning: Mar 12 11:06:16.524: //54/3816AF398074/AFW_:/AFW_Leg_PrecedenceDcValid: Mar 12 11:06:16.524: //54//Digi:/DigitCollect_MLPPTuning: Precednece Digit Colle ct not enabled Mar 12 11:06:16.524: //54/3816AF398074/AFW_:/AFW_Leg_TypeAheadGet: no chars in b uffer. Mar 12 11:06:16.524: //54//Digi:/AFW_M_DigitCollect_Initiate: copy dnis 3 to dig it collect buffer Mar 12 11:06:16.524: //54//Digi:/DigitCollect_DialPlanMatch: pattern offset=0, d igits=3 Mar 12 11:06:16.524: //54//Digi:/DigitCollect_DialPlanMatch: callParams->xruleCa lledTag = 1049077096 Mar 12 11:06:16.524: //54//Digi:/DigitCollect_DialPlanMatch: ed 3,calledlen 1, x late_result -4 Mar 12 11:06:16.524: //54//Digi:/DigitCollect_DialPlanMatch: src carrier id:, tg t carrier id: Mar 12 11:06:16.524: //54//Digi:/DigitCollect_DialPlanMatch: Match single infoty pe Mar 12 11:06:16.524: //-1/3816AF398074/DPM/dpMatchPeersCore: Calling Number=, Called Number=3, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:16.524: //-1/3816AF398074/DPM/dpMatchPeersCore: Match Rule=DP_MATCH_DEST; Called Number=3 Mar 12 11:06:16.524: //-1/3816AF398074/DPM/dpMatchPeersCore: Result=Partial Matches(1) after DP_MATCH_DEST Mar 12 11:06:16.524: //-1/3816AF398074/DPM/dpMatchSafModulePlugin: dialstring=3, saf_enabled=1, saf_dndb_lookup=0, dp_result=1 Mar 12 11:06:16.524: //-1/3816AF398074/DPM/dpMatchPeersMoreArg: Result=MORE_DIGITS_NEEDED(1) Mar 12 11:06:16.524: //54/3816AF398074/CCAPI/ccSetDigitTimeouts: Initial Digit Timeout=10000(ms), Inter Digit Timeout=10000(ms) Mar 12 11:06:16.524: //54/3816AF398074/CCAPI/ccSetDigitTimeouts: Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=10000(ms)) Mar 12 11:06:16.524: //54/3816AF398074/AFW_:/AFW_Leg_DigitReportEnable: Current: 0x0 Input: 0x2 Mar 12 11:06:16.524: //54/3816AF398074/CCAPI/ccCallReportDigits: (callID=0x36, digit_event=0x1, enable=TRUE, consume=FALSE) Mar 12 11:06:16.524: //54/3816AF398074/CCAPI/ccCallReportDigits: Enabled=TRUE, Call Id=54 Mar 12 11:06:16.524: //54//AFW_:/AFW_FSM_Drive: ACTION END: -------------(S_GETT INGDEST[4])--------------- Mar 12 11:06:16.524: //54//AFW_:/AFW_ExecEnv_SetModuleScope: Session_0x232FDE58_ 0_24216364 ---> TclModule_0x3D5CCE28_0_24216360 Mar 12 11:06:16.524: //54//AFW_:/AFW_ExecEnv_SetModuleScope: TclModule_0x3D5CCE2 8_0_24216360 ---> TclModule_0x3D5CCE28_0_24216360 Mar 12 11:06:16.524: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x21AF7B48, Type: Event, RefCount: 0 Mar 12 11:06:16.524: //54/3816AF398074/AFW_:/AFW_M_Event_Free: Mar 12 11:06:16.524: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x225E2690, Type: DataList, RefCount: 0 Mar 12 11:06:16.524: //-1//AFW_:/AFW_M_DataList_Free: Mar 12 11:06:16.524: //54//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1 Mar 12 11:06:16.636: //54/3816AF398074/CCAPI/cc_api_call_report_digits_done: (vdbPtr=0x224B4F54, callID=0x36, disp=0, digit_event=0x1, enable=TRUE, consum e=FALSE) Mar 12 11:06:16.636: //54/3816AF398074/CCAPI/cc_api_call_report_digits_done: Enabled=TRUE, Disposition=0x0, Interface=0x224B4F54, Call Id=54 Mar 12 11:06:16.636: //54/3816AF398074/CCAPI/cc_api_call_report_digits_done: Call Entry(Initial Digit Timeout=10000(ms), Inter Digit Timeout=10000(ms)) Mar 12 11:06:16.636: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event(0) Mar 12 11:06:16.636: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Event(Si ze=2864) Mar 12 11:06:16.636: //-1//AFW_:/AFW_DataList_New: Mar 12 11:06:16.636: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataList (Size=40) Mar 12 11:06:16.636: //54/3816AF398074/AFW_:/AFW_Process_GetCcqEvent: Received Mar 12 11:06:16.636: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_REP ORT_DIGITS_DONE(70)] { Mar 12 11:06:16.636: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x225CC630 ][Default] Mar 12 11:06:16.636: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[54][LEG_INCACK ED(2)][Cause(0)] Mar 12 11:06:16.636: //-1//AFW_:/AFW_Process_GetCcqEvent: } Mar 12 11:06:16.636: //-1//SSIN:/AFW_SS_MapEvent: No mapping required Mar 12 11:06:16.636: //54/3816AF398074/AFW_:/AFW_Object_WalkListeners: Mar 12 11:06:16.636: //54/3816AF398074/AFW_:/AFW_M_Object_ShowListeners: START Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_ 0x3E87A568_0_24216364] ( Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INC ACKED(2)][Cause(0)] Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Session_0x232 FDE58_0_24216364] ( Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INC ACKED(2)][Cause(0)] Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollec t_0x3E87A568_0_24216364] ( Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_I NCACKED(2)][Cause(0)] Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_0x3 D5CCE28_0_24216360] ( Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Session_0x2 32FDE58_0_24216364] ( Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_I NCACKED(2)][Cause(0)] Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitColl ect_0x3E87A568_0_24216364] ( Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG _INCACKED(2)][Cause(0)] Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INC ACKED(2)][Cause(0)] Mar 12 11:06:16.636: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.636: //54/3816AF398074/AFW_:/AFW_M_Object_ShowListeners: END Mar 12 11:06:16.636: //54/3816AF398074/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect Mar 12 11:06:16.636: //54//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitColl ect_0x3E87A568_0_24216364 Mar 12 11:06:16.636: //54//Digi:/AFW_M_DigitCollect_Action: Mar 12 11:06:16.636: //54//Digi:/act_DCRunning_RDone: id=54 Enable succeeded.ena ble=0 matchDialplan=1 numPatterns=0matchDialplanTerm=0 Mar 12 11:06:16.636: //54//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_0x3E87 A568_0_24216364 ---> NULL Mar 12 11:06:16.636: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x21AEBD18, Type: Event, RefCount: 0 Mar 12 11:06:16.636: //54/3816AF398074/AFW_:/AFW_M_Event_Free: Mar 12 11:06:16.640: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x225E26B8, Type: DataList, RefCount: 0 Mar 12 11:06:16.640: //-1//AFW_:/AFW_M_DataList_Free: Mar 12 11:06:16.640: //54//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1 Mar 12 11:06:16.644: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Calling Number=3, Called Number=101, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:16.644: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Result=NO_MATCH(-1) After All Match Rules Attempt Mar 12 11:06:16.644: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=-1 Mar 12 11:06:16.648: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Calling Number=3, Called Number=3, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:16.648: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Result=NO_MATCH(-1) After All Match Rules Attempt Mar 12 11:06:16.648: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=-1 Mar 12 11:06:16.840: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Calling Number=3, Called Number=101, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:16.840: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Result=NO_MATCH(-1) After All Match Rules Attempt Mar 12 11:06:16.840: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=-1 Mar 12 11:06:16.840: //54/3816AF398074/CCAPI/cc_api_call_digit_begin: Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1, Source Call Id=54, Digit=2, DigitBeginFlags=0x0, Rtp Timestamp=0x0, Rtp Expiration=0x0 Mar 12 11:06:16.840: //54/3816AF398074/CCAPI/cc_api_call_digit_end: Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1, Source Call Id=54, Digit=2, Duration=250, Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF Mar 12 11:06:16.840: //54/3816AF398074/CCAPI/cc_api_call_digit_end: Call Entry(Handoff Depth=0) Mar 12 11:06:16.840: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Calling Number=3, Called Number=3, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:16.840: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Result=NO_MATCH(-1) After All Match Rules Attempt Mar 12 11:06:16.840: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=-1 Mar 12 11:06:16.844: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event(0) Mar 12 11:06:16.844: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Event(Si ze=2864) Mar 12 11:06:16.844: //-1//AFW_:/AFW_DataList_New: Mar 12 11:06:16.844: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataList (Size=40) Mar 12 11:06:16.844: //54/3816AF398074/AFW_:/AFW_Process_GetCcqEvent: Received Mar 12 11:06:16.844: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIG IT_BEGIN(20)] { Mar 12 11:06:16.844: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x225CC630 ][Default] Mar 12 11:06:16.844: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[54][LEG_INCACK ED(2)][Cause(0)] Mar 12 11:06:16.844: //-1//AFW_:/AFW_Process_GetCcqEvent: } Mar 12 11:06:16.844: //-1//SSIN:/AFW_SS_MapEvent: No mapping required Mar 12 11:06:16.844: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x21AF59B8, Type: Event, RefCount: 0 Mar 12 11:06:16.844: //54/3816AF398074/AFW_:/AFW_M_Event_Free: Mar 12 11:06:16.844: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x225E2910, Type: DataList, RefCount: 0 Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_DataList_Free: Mar 12 11:06:16.844: //54//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1 Mar 12 11:06:16.844: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event(0) Mar 12 11:06:16.844: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Event(Si ze=2864) Mar 12 11:06:16.844: //-1//AFW_:/AFW_DataList_New: Mar 12 11:06:16.844: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataList (Size=40) Mar 12 11:06:16.844: //54/3816AF398074/AFW_:/AFW_Process_GetCcqEvent: Received Mar 12 11:06:16.844: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIG IT_END(19)] { Mar 12 11:06:16.844: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x225CC630 ][Default] Mar 12 11:06:16.844: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[54][LEG_INCACK ED(2)][Cause(0)] Mar 12 11:06:16.844: //-1//AFW_:/AFW_Process_GetCcqEvent: } Mar 12 11:06:16.844: //-1//SSIN:/AFW_SS_MapEvent: No mapping required Mar 12 11:06:16.844: //54/3816AF398074/AFW_:/AFW_M_Leg_EventPreProcess: Passing, not enabled.--- Mar 12 11:06:16.844: //54/3816AF398074/AFW_:/AFW_Object_WalkListeners: Mar 12 11:06:16.844: //54/3816AF398074/AFW_:/AFW_M_Object_ShowListeners: START Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_ 0x3E87A568_0_24216364] ( Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INC ACKED(2)][Cause(0)] Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Session_0x232 FDE58_0_24216364] ( Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INC ACKED(2)][Cause(0)] Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollec t_0x3E87A568_0_24216364] ( Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_I NCACKED(2)][Cause(0)] Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_0x3 D5CCE28_0_24216360] ( Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Session_0x2 32FDE58_0_24216364] ( Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_I NCACKED(2)][Cause(0)] Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitColl ect_0x3E87A568_0_24216364] ( Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG _INCACKED(2)][Cause(0)] Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INC ACKED(2)][Cause(0)] Mar 12 11:06:16.844: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:16.844: //54/3816AF398074/AFW_:/AFW_M_Object_ShowListeners: END Mar 12 11:06:16.844: //54/3816AF398074/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect Mar 12 11:06:16.844: //54//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitColl ect_0x3E87A568_0_24216364 Mar 12 11:06:16.844: //54//Digi:/AFW_M_DigitCollect_Action: Mar 12 11:06:16.848: //54//Digi:/act_DCRunning_Digit: : pLeg 54 Digit 2 Tone Mod e 0 Mar 12 11:06:16.848: //54//Digi:/DigitCollect_TreatDigit: Mar 12 11:06:16.848: //54//Digi:/DigitCollect_DialPlanMatch: pattern offset=0, d igits=32 Mar 12 11:06:16.848: //54//Digi:/DigitCollect_DialPlanMatch: src carrier id:, tg t carrier id: Mar 12 11:06:16.848: //54//Digi:/DigitCollect_DialPlanMatch: Match single infoty pe Mar 12 11:06:16.848: //-1/3816AF398074/DPM/dpMatchPeersCore: Calling Number=, Called Number=32, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:16.848: //-1/3816AF398074/DPM/dpMatchPeersCore: Match Rule=DP_MATCH_DEST; Called Number=32 Mar 12 11:06:16.848: //-1/3816AF398074/DPM/dpMatchPeersCore: Result=Partial Matches(1) after DP_MATCH_DEST Mar 12 11:06:16.848: //-1/3816AF398074/DPM/dpMatchSafModulePlugin: dialstring=32, saf_enabled=1, saf_dndb_lookup=0, dp_result=1 Mar 12 11:06:16.848: //-1/3816AF398074/DPM/dpMatchPeersMoreArg: Result=MORE_DIGITS_NEEDED(1) Mar 12 11:06:16.848: //54//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_0x3E87 A568_0_24216364 ---> NULL Mar 12 11:06:16.848: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x21AED378, Type: Event, RefCount: 0 Mar 12 11:06:16.848: //54/3816AF398074/AFW_:/AFW_M_Event_Free: Mar 12 11:06:16.848: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x225E2898, Type: DataList, RefCount: 0 Mar 12 11:06:16.848: //-1//AFW_:/AFW_M_DataList_Free: Mar 12 11:06:16.848: //54//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1 Mar 12 11:06:17.292: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Calling Number=3, Called Number=101, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:17.296: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Result=NO_MATCH(-1) After All Match Rules Attempt Mar 12 11:06:17.296: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=-1 Mar 12 11:06:17.296: //54/3816AF398074/CCAPI/cc_api_call_digit_begin: Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1, Source Call Id=54, Digit=1, DigitBeginFlags=0x0, Rtp Timestamp=0x0, Rtp Expiration=0x0 Mar 12 11:06:17.296: //54/3816AF398074/CCAPI/cc_api_call_digit_end: Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1, Source Call Id=54, Digit=1, Duration=250, Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF Mar 12 11:06:17.296: //54/3816AF398074/CCAPI/cc_api_call_digit_end: Call Entry(Handoff Depth=0) Mar 12 11:06:17.296: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Calling Number=3, Called Number=3, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:17.296: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Result=NO_MATCH(-1) After All Match Rules Attempt Mar 12 11:06:17.296: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=-1 Mar 12 11:06:17.296: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event(0) Mar 12 11:06:17.296: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Event(Si ze=2864) Mar 12 11:06:17.296: //-1//AFW_:/AFW_DataList_New: Mar 12 11:06:17.296: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataList (Size=40) Mar 12 11:06:17.296: //54/3816AF398074/AFW_:/AFW_Process_GetCcqEvent: Received Mar 12 11:06:17.296: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIG IT_BEGIN(20)] { Mar 12 11:06:17.296: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x225CC630 ][Default] Mar 12 11:06:17.296: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[54][LEG_INCACK ED(2)][Cause(0)] Mar 12 11:06:17.296: //-1//AFW_:/AFW_Process_GetCcqEvent: } Mar 12 11:06:17.296: //-1//SSIN:/AFW_SS_MapEvent: No mapping required Mar 12 11:06:17.296: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x21AEDEA8, Type: Event, RefCount: 0 Mar 12 11:06:17.296: //54/3816AF398074/AFW_:/AFW_M_Event_Free: Mar 12 11:06:17.296: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x225E28E8, Type: DataList, RefCount: 0 Mar 12 11:06:17.296: //-1//AFW_:/AFW_M_DataList_Free: Mar 12 11:06:17.296: //54//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1 Mar 12 11:06:17.296: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event(0) Mar 12 11:06:17.296: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Event(Si ze=2864)DigitCollect_0x3E87A568_0_24216364 ---> NULL Mar 12 11:06:17.300: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x21AF8678, Type: Event, RefCount: 0 Mar 12 11:06:17.300: //54/3816AF398074/AFW_:/AFW_M_Event_Free: Mar 12 11:06:17.300: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x225E2870, Type: DataList, RefCount: 0 Mar 12 11:06:17.300: //-1//AFW_:/AFW_M_DataList_Free: Mar 12 11:06:17.300: //54//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1 Mar 12 11:06:18.332: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Calling Number=3, Called Number=101, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:18.332: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Result=NO_MATCH(-1) After All Match Rules Attempt Mar 12 11:06:18.332: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=-1 Mar 12 11:06:18.332: //54/3816AF398074/CCAPI/cc_api_call_digit_begin: Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1, Source Call Id=54, Digit=4, DigitBeginFlags=0x0, Rtp Timestamp=0x0, Rtp Expiration=0x0 Mar 12 11:06:18.332: //54/3816AF398074/CCAPI/cc_api_call_digit_end: Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1, Source Call Id=54, Digit=4, Duration=250, Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF Mar 12 11:06:18.332: //54/3816AF398074/CCAPI/cc_api_call_digit_end: Call Entry(Handoff Depth=0) Mar 12 11:06:18.332: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Calling Number=3, Called Number=3, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:18.332: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Result=NO_MATCH(-1) After All Match Rules Attempt Mar 12 11:06:18.332: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=-1 Mar 12 11:06:18.336: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event(0) Mar 12 11:06:18.336: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Event(Size=2864) Mar 12 11:06:18.336: //-1//AFW_:/AFW_DataList_New: Mar 12 11:06:18.336: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataList(Size=40) Mar 12 11:06:18.336: //54/3816AF398074/AFW_:/AFW_Process_GetCcqEvent: Received Mar 12 11:06:18.336: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_BEGIN(20)] { Mar 12 11:06:18.336: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x225CC630][Default] Mar 12 11:06:18.336: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.336: //-1//AFW_:/AFW_Process_GetCcqEvent: } Mar 12 11:06:18.336: //-1//SSIN:/AFW_SS_MapEvent: No mapping required Mar 12 11:06:18.336: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x21AEE9D8, Type: Event, RefCount: 0 Mar 12 11:06:18.336: //54/3816AF398074/AFW_:/AFW_M_Event_Free: Mar 12 11:06:18.336: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x225E2938, Type: DataList, RefCount: 0 Mar 12 11:06:18.336: //-1//AFW_:/AFW_M_DataList_Free: Mar 12 11:06:18.336: //54//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1 Mar 12 11:06:18.344: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event(0) Mar 12 11:06:18.344: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Event(Size=2864) Mar 12 11:06:18.344: //-1//AFW_:/AFW_DataList_New: Mar 12 11:06:18.344: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataList(Size=40) Mar 12 11:06:18.344: //54/3816AF398074/AFW_:/AFW_Process_GetCcqEvent: Received Mar 12 11:06:18.344: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DIGIT_END(19)] { Mar 12 11:06:18.344: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x225CC630][Default] Mar 12 11:06:18.344: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.344: //-1//AFW_:/AFW_Process_GetCcqEvent: } Mar 12 11:06:18.344: //-1//SSIN:/AFW_SS_MapEvent: No mapping required Mar 12 11:06:18.344: //54/3816AF398074/AFW_:/AFW_M_Leg_EventPreProcess: Passing, not enabled.--- Mar 12 11:06:18.344: //54/3816AF398074/AFW_:/AFW_Object_WalkListeners: Mar 12 11:06:18.344: //54/3816AF398074/AFW_:/AFW_M_Object_ShowListeners: START Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_0x3E87A568_0_24216364] ( Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Session_0x232FDE58_0_24216364] ( Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_0x3E87A568_0_24216364] ( Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_0x3D5CCE28_0_24216360] ( Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Session_0x232FDE58_0_24216364] ( Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_0x3E87A568_0_24216364] ( Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.344: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.344: //54/3816AF398074/AFW_:/AFW_M_Object_ShowListeners: END Mar 12 11:06:18.344: //54/3816AF398074/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect Mar 12 11:06:18.344: //54//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_0x3E87A568_0_24216364 Mar 12 11:06:18.344: //54//Digi:/AFW_M_DigitCollect_Action: Mar 12 11:06:18.344: //54//Digi:/act_DCRunning_Digit: : pLeg 54 Digit 4 Tone Mode 0 Mar 12 11:06:18.344: //54//Digi:/DigitCollect_TreatDigit: Mar 12 11:06:18.344: //54//Digi:/DigitCollect_DialPlanMatch: pattern offset=0, digits=3214 Mar 12 11:06:18.344: //54//Digi:/DigitCollect_DialPlanMatch: src carrier id:, tgt carrier id: Mar 12 11:06:18.344: //54//Digi:/DigitCollect_DialPlanMatch: Match single infotype Mar 12 11:06:18.344: //-1/3816AF398074/DPM/dpMatchPeersCore: Calling Number=, Called Number=3214, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:18.344: //-1/3816AF398074/DPM/dpMatchPeersCore: Match Rule=DP_MATCH_DEST; Called Number=3214 Mar 12 11:06:18.344: //-1/3816AF398074/DPM/dpMatchPeersCore: Result=Success(0) after DP_MATCH_DEST Mar 12 11:06:18.344: //-1/3816AF398074/DPM/dpMatchSafModulePlugin: dialstring=3214, saf_enabled=1, saf_dndb_lookup=0, dp_result=0 Mar 12 11:06:18.344: //-1/3816AF398074/DPM/dpMatchPeersMoreArg: Result=SUCCESS(0) List of Matched Outgoing Dial-peer(s): 1: Dial-peer Tag=30 Mar 12 11:06:18.344: //54/3816AF398074/AFW_:/AFW_Leg_DigitReportDisable: Current: 0x2 Input: 0x1 Mar 12 11:06:18.344: //54/3816AF398074/CCAPI/ccCallReportDigits: (callID=0x36, digit_event=0x0, enable=FALSE, consume=FALSE) Mar 12 11:06:18.344: //54/3816AF398074/CCAPI/ccCallReportDigits: Enabled=TRUE, Call Id=54 Mar 12 11:06:18.344: //54/3816AF398074/CCAPI/cc_api_call_report_digits_done: (vdbPtr=0x224B4F54, callID=0x36, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE) Mar 12 11:06:18.344: //54/3816AF398074/CCAPI/cc_api_call_report_digits_done: Enabled=TRUE, Disposition=0x0, Interface=0x224B4F54, Call Id=54 Mar 12 11:06:18.344: //54/3816AF398074/CCAPI/cc_api_call_report_digits_done: Call Entry(Initial Digit Timeout=10000(ms), Inter Digit Timeout=10000(ms)) Mar 12 11:06:18.344: //54//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_0x3E87A568_0_24216364 ---> NULL Mar 12 11:06:18.344: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x21AEC848, Type: Event, RefCount: 0 Mar 12 11:06:18.348: //54/3816AF398074/AFW_:/AFW_M_Event_Free: Mar 12 11:06:18.348: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x225E2690, Type: DataList, RefCount: 0 Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_DataList_Free: Mar 12 11:06:18.348: //54//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1 Mar 12 11:06:18.348: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event(0) Mar 12 11:06:18.348: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Event(Size=2864) Mar 12 11:06:18.348: //-1//AFW_:/AFW_DataList_New: Mar 12 11:06:18.348: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataList(Size=40) Mar 12 11:06:18.348: //54/3816AF398074/AFW_:/AFW_Process_GetCcqEvent: Received Mar 12 11:06:18.348: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_REPORT_DIGITS_DONE(70)] { Mar 12 11:06:18.348: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x225CC630][Default] Mar 12 11:06:18.348: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.348: //-1//AFW_:/AFW_Process_GetCcqEvent: } Mar 12 11:06:18.348: //-1//SSIN:/AFW_SS_MapEvent: No mapping required Mar 12 11:06:18.348: //54/3816AF398074/AFW_:/AFW_Object_WalkListeners: Mar 12 11:06:18.348: //54/3816AF398074/AFW_:/AFW_M_Object_ShowListeners: START Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_0x3E87A568_0_24216364] ( Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Session_0x232FDE58_0_24216364] ( Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_0x3E87A568_0_24216364] ( Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_0x3D5CCE28_0_24216360] ( Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Session_0x232FDE58_0_24216364] ( Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_0x3E87A568_0_24216364] ( Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.348: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.348: //54/3816AF398074/AFW_:/AFW_M_Object_ShowListeners: END Mar 12 11:06:18.348: //54/3816AF398074/AFW_:/AFW_Object_WalkListeners: Entering Module : DigitCollect Mar 12 11:06:18.348: //54//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> DigitCollect_0x3E87A568_0_24216364 Mar 12 11:06:18.348: //54//Digi:/AFW_M_DigitCollect_Action: Mar 12 11:06:18.348: //54//Digi:/act_DCRunning_RDone: id=54 Reporting disabled. Mar 12 11:06:18.348: //-1//Digi:/DigitCollect_Complete: DC_MATCHED_DIALPLAN. Digits=3214 Mar 12 11:06:18.348: //54//Digi:/DigitCollect_MLPPPostAdjust: Non MLPP call Mar 12 11:06:18.348: //-1//AFW_:/AFW_Event_New: Event ID: ev_collectdigits_done(256) Mar 12 11:06:18.348: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Event(Size=2864) Mar 12 11:06:18.348: //-1//AFW_:/AFW_DataList_New: Mar 12 11:06:18.348: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataList(Size=40) Mar 12 11:06:18.348: //54//AFW_:/AFW_Module_ReturnArgEv: Mar 12 11:06:18.348: //-1//AFW_:/AFW_DataList_New: Mar 12 11:06:18.348: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataList(Size=40) Mar 12 11:06:18.348: //-1//AFW_:/AFW_DataList_Enqueue: Trying to add element to a list Mar 12 11:06:18.348: //-1//AFW_:/AFW_DataList_GetWrapper: Looking for list element 0x3E86C86C Mar 12 11:06:18.348: //-1//AFW_:/AFW_DataList_Enqueue: Adding element: Mar 12 11:06:18.348: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x3E86C86C, Type: Leg, RefCount: 5 Mar 12 11:06:18.348: //-1//AFW_:/AFW_DataList_GetFirst: Elem = 0x3DF0966C, with Instance = 0x3E86C86C Mar 12 11:06:18.348: //54//AFW_:/AFW_Module_ReturnArgEv: Return List (remove=TRUE){LEG[54 ][LEG_INCACKED(2)][Cause(0)]} Mar 12 11:06:18.348: //54/3816AF398074/AFW_:/AFW_Object_RemoveListener: Mar 12 11:06:18.352: //-1//AFW_:/AFW_DataArray_ElementDelete: param name LEG_54 Mar 12 11:06:18.352: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x3E86C86C, Type: Leg, RefCount: 4 Mar 12 11:06:18.352: //54//AFW_:/AFW_Module_UnListen: NumObjects: 0 Mar 12 11:06:18.352: //54//AFW_:/AFW_ExecEnv_SetModuleScope: DigitCollect_0x3E87A568_0_24216364 ---> NULL Mar 12 11:06:18.352: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x21AEF508, Type: Event, RefCount: 0 Mar 12 11:06:18.352: //54/3816AF398074/AFW_:/AFW_M_Event_Free: Mar 12 11:06:18.352: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x225E26B8, Type: DataList, RefCount: 0 Mar 12 11:06:18.352: //-1//AFW_:/AFW_M_DataList_Free: Mar 12 11:06:18.352: //54//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1 Mar 12 11:06:18.352: //54//AFW_:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED Mar 12 11:06:18.352: //54//AFW_:/AFW_Process_GetPriorityQEvent: Received Mar 12 11:06:18.352: //-1//AFW_:/AFW_Process_GetPriorityQEvent: Event[APP_EV_DIGITCOLLECT_DONE(256)] { Mar 12 11:06:18.352: //-1//AFW_:/AFW_Process_GetPriorityQEvent: EXECENV[0x225CC630][Default] Mar 12 11:06:18.352: //-1//AFW_:/AFW_Process_GetPriorityQEvent: MOD[DigitCollect_0x3E87A568_0_24216364] ( Mar 12 11:06:18.352: //-1//AFW_:/AFW_Process_GetPriorityQEvent: ) Mar 12 11:06:18.352: //-1//AFW_:/AFW_Process_GetPriorityQEvent: } Mar 12 11:06:18.352: //54//Digi:/AFW_M_DigitCollect_EventPreProcess: Mar 12 11:06:18.352: //54//Digi:/DigitCollectEnd_UpdateStats: Mar 12 11:06:18.352: //54//AFW_:/AFW_Object_WalkListeners: Mar 12 11:06:18.352: //54//AFW_:/AFW_M_Object_ShowListeners: START Mar 12 11:06:18.352: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Session_0x232FDE58_0_24216364] ( Mar 12 11:06:18.352: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[54][LEG_INCACKED(2)][Cause(0)] Mar 12 11:06:18.352: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[DigitCollect_0x3E87A568_0_24216364] ( Mar 12 11:06:18.352: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.352: //-1//AFW_:/AFW_M_Object_ShowListeners: ) Mar 12 11:06:18.352: //54//AFW_:/AFW_M_Object_ShowListeners: END Mar 12 11:06:18.352: //54//AFW_:/AFW_Object_WalkListeners: Entering Module : Session Mar 12 11:06:18.352: //-1//AFW_:/AFW_DataList_GetFirst: Elem = 0x3DF0966C, with Instance = 0x3E86C86C Mar 12 11:06:18.352: //54/3816AF398074/AFW_:/AFW_Object_AddListener: adding Module Session as listener Mar 12 11:06:18.352: //54//AFW_:/AFW_Object_RemoveListener: Mar 12 11:06:18.352: //-1//AFW_:/AFW_DataArray_ElementDelete: param name DigitCollect_0x3E87A568_0_24216364 Mar 12 11:06:18.352: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x3E87A568, Type: DigitCollect, RefCount: 1 Mar 12 11:06:18.352: //54//AFW_:/AFW_Module_UnListen: NumObjects: 1 Mar 12 11:06:18.352: //54//AFW_:/AFW_ExecEnv_SetModuleScope: NULL ---> Session_0x232FDE58_0_24216364 Mar 12 11:06:18.352: //54//AFW_:/AFW_FSM_Drive: ACTION BEGIN: ------(S_GETTINGDEST[4],ev_collectdigits_done[256])---[C_Action]------ Mar 12 11:06:18.352: //54//AFW_:/GettingDest_DigitCollectDone: status(4) discCause(0) ovrlp(TRUE) Mar 12 11:06:18.352: //54/3816AF398074/CCAPI/ccCallProceeding: Progress Indication=NULL(0) Mar 12 11:06:18.352: //-1//AFW_:/AFW_Util_GetUserFromURL: Mar 12 11:06:18.352: destination: 3214 Mar 12 11:06:18.352: //-1//AFW_:/AFW_Util_GetUserFromURL: Mar 12 11:06:18.352: ret_val : 3214 Mar 12 11:06:18.352: //-1//AFW_:/AFW_Util_CopyLegServiceCodeToCallInfoContainer: Service Code not available on Leg Mar 12 11:06:18.352: //-1//AFW_:/AFW_Util_CopyLegRouteCodeToCallInfoContainer: Route Code not available on Leg Mar 12 11:06:18.352: //-1//AFW_:/AFW_Util_GetTgCicValue: CIC Not found for tag(56) Mar 12 11:06:18.352: //54//AFW_:/SetupDestinationSnrHandler: Mar 12 11:06:18.352: //54//AFW_:/ProcessSnrDestination: Mar 12 11:06:18.352: //-1/3816AF398074/DPM/dpMatchPeersCore: Calling Number=, Called Number=3214, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:18.352: //-1/3816AF398074/DPM/dpMatchPeersCore: Match Rule=DP_MATCH_DEST; Called Number=3214 Mar 12 11:06:18.352: //-1/3816AF398074/DPM/dpMatchPeersCore: Result=Success(0) after DP_MATCH_DEST Mar 12 11:06:18.352: //-1/3816AF398074/DPM/dpMatchSafModulePlugin: dialstring=3214, saf_enabled=0, saf_dndb_lookup=1, dp_result=0 Mar 12 11:06:18.352: //-1/3816AF398074/DPM/dpMatchPeersMoreArg: Result=SUCCESS(0) List of Matched Outgoing Dial-peer(s): 1: Dial-peer Tag=30 Mar 12 11:06:18.352: //54//AFW_:/ResetSnrParamenter: Mar 12 11:06:18.352: //54//AFW_:/SetupDestinationSnrHandler: not snr call Mar 12 11:06:18.352: //-1/3816AF398074/DPM/dpMatchPeersCore: Calling Number=, Called Number=3214, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:18.352: //-1/3816AF398074/DPM/dpMatchPeersCore: Match Rule=DP_MATCH_DEST; Called Number=3214 Mar 12 11:06:18.352: //-1/3816AF398074/DPM/dpMatchPeersCore: Result=Success(0) after DP_MATCH_DEST Mar 12 11:06:18.352: //-1/3816AF398074/DPM/dpMatchSafModulePlugin: dialstring=3214, saf_enabled=0, saf_dndb_lookup=1, dp_result=0 Mar 12 11:06:18.352: //-1/3816AF398074/DPM/dpMatchPeersMoreArg: Result=SUCCESS(0) List of Matched Outgoing Dial-peer(s): 1: Dial-peer Tag=30 Mar 12 11:06:18.352: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore: Calling Number=3214, Called Number=3214, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:18.352: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore: Match Rule=DP_MATCH_DEST; Called Number=3214 Mar 12 11:06:18.352: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore: Result=Success(0) after DP_MATCH_DEST Mar 12 11:06:18.352: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=3214, saf_enabled=0, saf_dndb_lookup=1, dp_result=0 Mar 12 11:06:18.352: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg: Result=SUCCESS(0) List of Matched Outgoing Dial-peer(s): 1: Dial-peer Tag=30 Mar 12 11:06:18.352: //54//AFW_:/SetupValidateSharedln: calledNum=3214, callingNum=101, callID=54, callinf.peertag=40003, joinXtoID=-1 Mar 12 11:06:18.352: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Calling Number=3, Called Number=, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:18.352: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Result=NO_MATCH(-1) After All Match Rules Attempt Mar 12 11:06:18.352: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=-1 Mar 12 11:06:18.352: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Calling Number=3214, Called Number=, Voice-Interface=0x0, Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:18.352: //-1/xxxxxxxxxxxx/DPM/dpAssociateIncomingPeerCore: Result=Success(0) after DP_MATCH_ORIGINATE; Incoming Dial-peer=30 Mar 12 11:06:18.352: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=NULL, saf_enabled=0, saf_dndb_lookup=0, dp_result=0 Mar 12 11:06:18.352: //54//AFW_:/SetupDestination: Mar 12 11:06:18.352: destinations[0] = 3214 Mar 12 11:06:18.352: //-1//AFW_:/AFW_ExecEnv_CallProc: CallSetup::Start Mar 12 11:06:18.352: //54//CSPK:/C_CallSetup_Start: ControlInfo = 0x232FFCAC, callInfo = 0x232FF398, destination[0]=3214 Mar 12 11:06:18.352: //54//PACK:/ParamRead: Reading param mode from callsetup Mar 12 11:06:18.352: //-1//PACK:/ParamRead: Reading parameter mode for a script callsetup, Mar 12 11:06:18.352: //-1//PACK:/ParamRead: appRegParams=0x2253D090 dpParamArray=0x22BBC700 pMainParamArray=0x0 Mar 12 11:06:18.352: //-1//PACK:/ParamRead: dial-peer level: script callsetup, Mar 12 11:06:18.352: //-1//PACK:/ParamRead: dpParamArray=0x22BBC700 dpGroupList=0x0 Mar 12 11:06:18.352: //-1//PACK:/ParamRead_ElementGetWithGroup: Looking for param callsetup.mode Mar 12 11:06:18.352: //-1//PACK:/ParamRead_ElementGetWithGroup: Param callsetup.mode was not found in this container Mar 12 11:06:18.356: //-1//PACK:/ParamRead: Parameter for the script: callsetup has been read: mode Mar 12 11:06:18.356: //-1//AFW_:/AFW_DataString_Get: Mar 12 11:06:18.356: //54//CSPK:/C_CallSetup_Start: configured mode=rotary (1) Mar 12 11:06:18.356: //54//PACK:/ParamRead: Reading param fac-mode from callsetup Mar 12 11:06:18.356: //-1//PACK:/ParamRead: Reading parameter fac-mode for a script callsetup, Mar 12 11:06:18.356: //-1//PACK:/ParamRead: appRegParams=0x2253D090 dpParamArray=0x22BBC700 pMainParamArray=0x0 Mar 12 11:06:18.356: //-1//PACK:/ParamRead: dial-peer level: script callsetup, Mar 12 11:06:18.356: //-1//PACK:/ParamRead: dpParamArray=0x22BBC700 dpGroupList=0x0 Mar 12 11:06:18.356: //-1//PACK:/ParamRead_ElementGetWithGroup: Looking for param callsetup.fac-mode Mar 12 11:06:18.356: //-1//PACK:/ParamRead_ElementGetWithGroup: Param callsetup.fac-mode was not found in this container Mar 12 11:06:18.356: //-1//PACK:/ParamRead: Parameter for the script: callsetup was NOT found: fac-mode Mar 12 11:06:18.356: //-1//Call:/AFW_CallSetup_New: Mar 12 11:06:18.356: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: CallSetup(Size=5000) Mar 12 11:06:18.356: //-1//AFW_:/AFW_DataArray_New: Mar 12 11:06:18.356: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataArray(Size=80) Mar 12 11:06:18.356: //-1//AFW_:/AFW_FSM_New: Mar 12 11:06:18.356: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: FSM(Size=104) Mar 12 11:06:18.356: //-1//AFW_:LP:EE225CC630000:HN01718A54:/AFW_M_Object_SetExecEnv: ObjCount: 5, CmdPending 1 Mar 12 11:06:18.356: //54//AFW_:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 2 Mar 12 11:06:18.356: //54//AFW_:/AFW_Object_AddListener: adding Module Session as listener Mar 12 11:06:18.356: //54//AFW_:/AFW_M_Module_GetHandle: Module handle: CallSetup_0x2330E76C_0_24218196 Mar 12 11:06:18.356: //-1//AFW_:/AFW_DataArray_ElementSet: Adding param: CallSetup_0x2330E76C_0_24218196, type: CallSetup Mar 12 11:06:18.356: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x2330E76C, Type: CallSetup, RefCount: 2 Mar 12 11:06:18.356: //54//Call:/AFW_CallSetup_AddDest: 3214 index 0 Mar 12 11:06:18.356: //54//Call:/AFW_CallSetup_SetIntWrkLeg: Mar 12 11:06:18.356: //54/3816AF398074/AFW_:/AFW_Leg_SignalPeerGet: Leg [54] Mar 12 11:06:18.356: //-1//AFW_:/AFW_ExecEnv_CallProc: Session::GetSigPeer Mar 12 11:06:18.356: //-1//AFW_:/C_PackageSession_GetSigPeer: Mar 12 11:06:18.356: //54//Call:/AFW_M_CallSetup_Initiate: Mar 12 11:06:18.356: //54/3816AF398074/AFW_:/AFW_Leg_SetMLPPInfo: Unable to set mlpp info Mar 12 11:06:18.356: //-1//AFW_:/AFW_Util_CopyMLPPDataToCallInfoContainer: Voice MLPP not configured Mar 12 11:06:18.356: //54//Call:/CS_UpdateMLPPInfo: ServiceDomain:[none (0)] DomainIdentifier:[000000] PrecedenceLevel:[-1 (PRECEDENCE_LEVEL_NONE)] NormalizedPrecedence:[0 (INTERNAL_PRECEDENCE_0)] Preempt Hunt Not Set Mar 12 11:06:18.356: //54//Call:/CallSetupInitiate: Mar 12 11:06:18.356: //54//Call:/CS_Placecall: Mar 12 11:06:18.356: //-1//AFW_:/AFW_Util_GetUserFromURL: Mar 12 11:06:18.356: destination: 3214 Mar 12 11:06:18.356: //-1//AFW_:/AFW_Util_GetUserFromURL: Mar 12 11:06:18.356: ret_val : 3214 Mar 12 11:06:18.356: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore: Calling Number=, Called Number=3214, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:18.356: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore: Match Rule=DP_MATCH_DEST; Called Number=3214 Mar 12 11:06:18.356: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersCore: Result=Success(0) after DP_MATCH_DEST Mar 12 11:06:18.356: //-1/xxxxxxxxxxxx/DPM/dpMatchSafModulePlugin: dialstring=3214, saf_enabled=0, saf_dndb_lookup=1, dp_result=0 Mar 12 11:06:18.356: //-1/xxxxxxxxxxxx/DPM/dpMatchPeersMoreArg: Result=SUCCESS(0) List of Matched Outgoing Dial-peer(s): 1: Dial-peer Tag=30 Mar 12 11:06:18.356: //54//Call:/setupHuntGroupInfo: set intWrkLeg id=54 hgTag=-1 oldhgTag=-1 bacd=0 Mar 12 11:06:18.356: //54//Call:/CS_Placecall: enable reroute_ind intercept for reroutemode REDIRECT_ROTARY Mar 12 11:06:18.356: //54/3816AF398074/AFW_:/AFW_Leg_SetMLPPInfo: Unable to set mlpp info Mar 12 11:06:18.356: //-1//AFW_:/AFW_Util_CopyMLPPDataToCallInfoContainer: Voice MLPP not configured Mar 12 11:06:18.356: //54//Call:/CS_UpdateMLPPInfo: ServiceDomain:[none (0)] DomainIdentifier:[000000] PrecedenceLevel:[-1 (PRECEDENCE_LEVEL_NONE)] NormalizedPrecedence:[0 (INTERNAL_PRECEDENCE_0)] Preempt Hunt Not Set Mar 12 11:06:18.356: //-1//Dest:/AFW_Destination_New: Mar 12 11:06:18.356: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Destination(Size=13040) Mar 12 11:06:18.356: //-1//AFW_:/AFW_DataArray_New: Mar 12 11:06:18.356: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: DataArray(Size=80) Mar 12 11:06:18.356: //-1//AFW_:/AFW_FSM_New: Mar 12 11:06:18.356: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: FSM(Size=104) Mar 12 11:06:18.356: //-1//AFW_:/AFW_FSM_New: Mar 12 11:06:18.356: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: FSM(Size=104) Mar 12 11:06:18.356: //-1//AFW_:LP:EE225CC630000:HN01718A54:/AFW_M_Object_SetExecEnv: ObjCount: 6, CmdPending 2 Mar 12 11:06:18.356: //54//AFW_:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 3 Mar 12 11:06:18.356: //54//AFW_:/AFW_Object_AddListener: adding Module CallSetup as listener Mar 12 11:06:18.356: //54//AFW_:/AFW_M_Module_GetHandle: Module handle: Destination_0x210AAE8C_0_24218196 Mar 12 11:06:18.356: //-1//AFW_:/AFW_DataArray_ElementSet: Adding param: Destination_0x210AAE8C_0_24218196, type: Destination Mar 12 11:06:18.356: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x210AAE8C, Type: Destination, RefCount: 2 Mar 12 11:06:18.356: //54//Dest:/AFW_Destination_AddDest: Mar 12 11:06:18.356: //-1//Dest:/AFW_Destination_AddDest: adding destination "3214" Mar 12 11:06:18.356: //54//Dest:/AFW_Destination_SetIntWrkLeg: LEG[54 ][LEG_INCPROCEED(3)][Cause(0)] Mar 12 11:06:18.356: //54//Dest:/TermInterworking: current state IW_STATE_INIT, Keep IntWrkLeg Mar 12 11:06:18.356: //54//Dest:/DestSetIntWrkLeg: Mar 12 11:06:18.356: //54/3816AF398074/AFW_:/AFW_Object_AddListener: adding Module Destination as listener Mar 12 11:06:18.356: //-1//AFW_:/AFW_DataArray_ElementSet: Adding param: LEG_54, type: Leg Mar 12 11:06:18.356: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x3E86C86C, Type: Leg, RefCount: 5 Mar 12 11:06:18.356: //54//Dest:/AFW_M_Destination_Initiate: Mar 12 11:06:18.356: //-1//AFW_:/AFW_Util_SaveRawMsg: Mar 12 11:06:18.356: //54//Dest:/AFW_M_Destination_Initiate: Outgoing guid : 3816AF39.251C11E8.8074A12D.7BD103A0 Mar 12 11:06:18.356: Incoming_guid : 00000000.00000000.00000000.00000000 Mar 12 11:06:18.356: //54//Dest:/AFW_M_Destination_Initiate: Outgoing gcid : 38174B61.251C11E8.8077A12D.7BD103A0 Mar 12 11:06:18.356: Incoming_gcid : 00000000.00000000.00000000.00000000 Mar 12 11:06:18.356: //54/3816AF398074/AFW_:/AFW_Leg_SetMLPPInfo: Unable to set mlpp info Mar 12 11:06:18.356: //-1//AFW_:/AFW_Util_CopyMLPPDataToCallInfoContainer: Voice MLPP not configured Mar 12 11:06:18.356: //54//Dest:/DestUpdateMLPPInfo: ServiceDomain:[none (0)] DomainIdentifier:[000000] PrecedenceLevel:[-1 (PRECEDENCE_LEVEL_NONE)] NormalizedPrecedence:[-1 (PRECEDENCE_LEVEL_NONE)] Preempt Hunt Not Set Mar 12 11:06:18.356: //54//Dest:/DestSetupInitiate: Mar 12 11:06:18.356: //54/3816AF398074/SSIN:/AFW_SS_SIP_CheckConsultSetup: Mar 12 11:06:18.356: //54/3816AF398074/SSIN:/AFW_SS_SIP_CheckConsultSetup: NULL setupSSApduList Mar 12 11:06:18.356: //54//Dest:/DestLocalConsultHandoff: no local handoff, intwrk leg 3E86C86C, consult id 3DF72980 Mar 12 11:06:18.360: //54//Dest:/DestNoForwardLocalCalls: Not a forwarded call. No restriction on forwarding calls Mar 12 11:06:18.360: //54//Dest:/DestAddRerouteSetupInfo: Mar 12 11:06:18.360: //54//Dest:/DestAddTransferSetupInfo: Mar 12 11:06:18.360: //-1//AFW_:/AFW_Util_CopyCallDataToCallInfo: copied 3214 Mar 12 11:06:18.360: //54//PACK:/ParamRead: Reading param after-hours-exempt from callsetup Mar 12 11:06:18.360: //-1//PACK:/ParamRead: Reading parameter after-hours-exempt for a script callsetup, Mar 12 11:06:18.360: //-1//PACK:/ParamRead: appRegParams=0x2253D090 dpParamArray=0x22BBC700 pMainParamArray=0x0 Mar 12 11:06:18.360: //-1//PACK:/ParamRead: dial-peer level: script callsetup, Mar 12 11:06:18.360: //-1//PACK:/ParamRead: dpParamArray=0x22BBC700 dpGroupList=0x0 Mar 12 11:06:18.360: //-1//PACK:/ParamRead_ElementGetWithGroup: Looking for param callsetup.after-hours-exempt Mar 12 11:06:18.360: //-1//PACK:/ParamRead: Parameter for the script: callsetup has been read: after-hours-exempt Mar 12 11:06:18.360: //-1//AFW_:/AFW_DataBoolean_Get: Mar 12 11:06:18.360: //54//Dest:/DestMatchDialPeer: Mar 12 11:06:18.360: //54//Dest:/DestMatchDialPeer: src carrier id:, tgt carrier id: Mar 12 11:06:18.360: //-1/3816AF398074/DPM/dpMatchPeersCore: Calling Number=, Called Number=3214, Peer Info Type=DIALPEER_INFO_SPEECH Mar 12 11:06:18.360: //-1/3816AF398074/DPM/dpMatchPeersCore: Match Rule=DP_MATCH_DEST; Called Number=3214 Mar 12 11:06:18.360: //-1/3816AF398074/DPM/dpMatchPeersCore: Result=Success(0) after DP_MATCH_DEST Mar 12 11:06:18.360: //-1/3816AF398074/DPM/dpMatchSafModulePlugin: dialstring=3214, saf_enabled=1, saf_dndb_lookup=1, dp_result=0 Mar 12 11:06:18.360: //-1/3816AF398074/DPM/dpMatchPeersMoreArg: Result=SUCCESS(0) List of Matched Outgoing Dial-peer(s): 1: Dial-peer Tag=30 Mar 12 11:06:18.360: //54//Dest:/DestQueuePeers: Matched peers: Mar 12 11:06:18.360: //54//Dest:/DestPeerItemUpdatePreemptInfo: Mar 12 11:06:18.360: //54//Dest:/DestPeerItemResetLPCORInfo: Mar 12 11:06:18.360: //-1//Dest:/DestQueuePeers: 30 Mar 12 11:06:18.360: //-1//Dest:/DestQueuePeers: , Total(1) Mar 12 11:06:18.360: //54//Dest:/DestDialPeerRotary: Mar 12 11:06:18.360: //54//Dest:/DestOutboundCallUsingPeer: dest(3214), numexpDest(3214), numDestDigits(4) Mar 12 11:06:18.360: //54//Dest:/DestOutboundCallUsingPeer: prefix(168.1.100), peer tag(30) Mar 12 11:06:18.360: //54//Dest:/DestUpdatePreemptSetupInfo: Mar 12 11:06:18.360: //54//Dest:/DestDialPeerFilter: Mar 12 11:06:18.360: //54//Dest:/DestDialPeerFilter: Checking peer [30] Mar 12 11:06:18.360: //54//Dest:/DestPeerFilterRouteCode: Route Code not available in callInfo Mar 12 11:06:18.360: //-1//Dest:/DestOutboundCallUsingPeer: Outgoing Tag(30) calling[101] called[3214] Mar 12 11:06:18.360: //54//OSP :/Dest_Settlement_MatrixCheck: retcode=1 cid(54) trans=0x0, provider=0 No settle-call present Mar 12 11:06:18.360: //54//Dest:/DestCheckTeleUnassBusy: Mar 12 11:06:18.360: //54//Dest:/DestHandleLPCOR: Mar 12 11:06:18.360: //54//Dest:/DestSetup: Mar 12 11:06:18.360: //-1//Dest:/DestSetup: Mar 12 11:06:18.360: :DestSetup iw inc guid is 0-0-0-0 Mar 12 11:06:18.360: //-1//Dest:/DestSetup: Mar 12 11:06:18.360: :DestSetup iw guid is 3816AF39-251C11E8-8074A12D-7BD103A0 Mar 12 11:06:18.360: :DestSetup iw guid is 3816AF39-251C11E8-8074A12D-7BD103A0 Mar 12 11:06:18.360: //-1//Dest:/DestSetup: Mar 12 11:06:18.360: :DestSetup iw inc gcid is 0-0-0-0 Mar 12 11:06:18.360: :DestSetup iw gcid is 38174B61-251C11E8-8077A12D-7BD103A0 Mar 12 11:06:18.360: //-1//SSIN:/AFW_SS_H450_PrepareCIInform: Mar 12 11:06:18.360: //54//Dest:/DestSetup: snrPeerCallID 0 intWrkLegID 54 Mar 12 11:06:18.360: //-1//AFW_:/AFW_Leg_New: Mar 12 11:06:18.360: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Leg(Size=5488) Mar 12 11:06:18.360: //54/3816AF398074/CCAPI/ccCallSetupRequest: Destination=, Calling IE Present=TRUE, Mode=0, Outgoing Dial-peer=30, Params=0x3E86B34C, Progress Indication=NULL(0) Mar 12 11:06:18.360: //54/3816AF398074/CCAPI/ccCheckClipClir: In: Calling Number=101(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed) Mar 12 11:06:18.360: //54/3816AF398074/CCAPI/ccCheckClipClir: Out: Calling Number=101(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed) Mar 12 11:06:18.360: //54/3816AF398074/CCAPI/ccCallSetupRequest: Destination Pattern=3214, Called Number=3214, Digit Strip=FALSE Mar 12 11:06:18.360: //54/3816AF398074/CCAPI/ccCallSetupRequest: Calling Number=101(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed), Called Number=3214(TON=Unknown, NPI=Unknown), Redirect Number=, Display Info=IT Support Account Number=101, Final Destination Flag=FALSE, Guid=3816AF39-251C-11E8-8074-A12D7BD103A0, Outgoing Dial-peer=30 Mar 12 11:06:18.360: //54/3816AF398074/CCAPI/cc_api_display_ie_subfields: ccCallSetupRequest: cisco-username=101 ----- ccCallInfo IE subfields ----- cisco-ani=101 cisco-anitype=0 cisco-aniplan=0 cisco-anipi=0 cisco-anisi=0 dest=3214 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 Mar 12 11:06:18.360: //54/3816AF398074/CCAPI/ccIFCallSetupRequestPrivate: Interface=0x3D4A910C, Interface Type=1, Destination=, Mode=0x0, Call Params(Calling Number=101,(Calling Name=IT Support)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed), Called Number=3214(TON=Unknown, NPI=Unknown), Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=FALSE, Outgoing Dial-peer=30, Call Count On=FALSE, Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=) Mar 12 11:06:18.360: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 12 11:06:18.360: :cc_get_feature_vsa malloc success Mar 12 11:06:18.360: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 12 11:06:18.360: cc_get_feature_vsa count is 2 Mar 12 11:06:18.360: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 12 11:06:18.360: :FEATURE_VSA attributes are: feature_name:0,feature_time:987259720,feature_id:31 Mar 12 11:06:18.360: //55/3816AF398074/CCAPI/ccIFCallSetupRequestPrivate: SPI Call Setup Request Is Success; Interface Type=1, FlowMode=1 Mar 12 11:06:18.360: //55/3816AF398074/AFW_:/AFW_Leg_NewSetupRequest: ccCallSetupRequest done Mar 12 11:06:18.360: //55/3816AF398074/CCAPI/ccCallSetContext: Context=0x3E86B2FC Mar 12 11:06:18.360: //54/3816AF398074/CCAPI/ccSaveDialpeerTag: Outgoing Dial-peer=30 Mar 12 11:06:18.360: //-1//Dest:/DestSetup: Mar 12 11:06:18.360: :DestSetup setup inc guid is 0-0-0-0 Mar 12 11:06:18.360: //-1//Dest:/DestSetup: Mar 12 11:06:18.360: :DestSetup setup guid is 3816AF39-251C11E8-8074A12D-7BD103A0 Mar 12 11:06:18.360: //-1//Dest:/DestSetup: Mar 12 11:06:18.360: :DestSetup setup inc gcid is 0-0-0-0 Mar 12 11:06:18.360: :DestSetup setup gcid is 38174B61-251C11E8-8077A12D-7BD103A0 Mar 12 11:06:18.360: //55/3816AF398074/AFW_:/AFW_M_Leg_SetExecEnv: Mar 12 11:06:18.360: //54//AFW_:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 4 Mar 12 11:06:18.360: //-1/3816AF398074/AFW_:LP:EE225CC630000:LG55:/AFW_M_Object_SetExecEnv: ObjCount: 7, CmdPending 4 Mar 12 11:06:18.360: //55/3816AF398074/AFW_:/AFW_Object_AddListener: adding Module Destination as listener Mar 12 11:06:18.360: //55/3816AF398074/AFW_:/AFW_M_Leg_GetHandle: Leg handle: LEG_55 Mar 12 11:06:18.360: //-1//AFW_:/AFW_DataArray_ElementSet: Adding param: LEG_55, type: Leg Mar 12 11:06:18.364: //-1//AFW_:/AFW_Instance_IncrRefCount: Object: 0x3E86B2FC, Type: Leg, RefCount: 2 Mar 12 11:06:18.364: //55/3816AF398074/AFW_:/AFW_Leg_UpdateStats: Updating stats for ID 13 type 3 Mar 12 11:06:18.364: //54//Dest:/DestSetup: Destination setup success Mar 12 11:06:18.364: //54//Dest:/AFW_M_Destination_Initiate: attempting call to destination 3214 Mar 12 11:06:18.364: //54//Call:/CS_Placecall: Call placed to 3214 index 0 Mar 12 11:06:18.364: //54//AFW_:/AFW_FSM_Drive: ACTION END: -------------(S_CONTACTINGDEST[5])--------------- Mar 12 11:06:18.364: //54//AFW_:/AFW_ExecEnv_SetModuleScope: Session_0x232FDE58_0_24216364 ---> NULL Mar 12 11:06:18.364: //54//AFW_:/AFW_Object_WalkListeners: Mar 12 11:06:18.364: //54//AFW_:/AFW_M_Object_ShowListeners: START Mar 12 11:06:18.364: //54//AFW_:/AFW_M_Object_ShowListeners: END Mar 12 11:06:18.364: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x21AF21C8, Type: Event, RefCount: 0 Mar 12 11:06:18.364: //54//AFW_:/AFW_M_Event_Free: Mar 12 11:06:18.364: //54//AFW_:/AFW_M_Event_Free: MODULEDONEEVENT for a Module: DigitCollect_0x3E87A568_0_24216364 Mar 12 11:06:18.364: //54//AFW_:/AFW_Object_RemoveAllListener: Mar 12 11:06:18.364: //-1//AFW_:/AFW_M_Object_UnSetExecEnv: ObjCount: 6, CmdPending 4 Mar 12 11:06:18.364: //-1//AFW_:HN0171832C:/AFW_M_Event_Free: ExecEnv objCount: 6 Mar 12 11:06:18.364: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x3E87A568, Type: DigitCollect, RefCount: 0 Mar 12 11:06:18.364: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x3D638F24, Type: DataArray, RefCount: 0 Mar 12 11:06:18.364: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x225E2898, Type: DataList, RefCount: 0 Mar 12 11:06:18.364: //-1//AFW_:/AFW_M_DataList_Free: Mar 12 11:06:18.364: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x3E86C86C, Type: Leg, RefCount: 4 Mar 12 11:06:18.364: //-1//AFW_:/AFW_Instance_DecrRefCount: Object: 0x225E2910, Type: DataList, RefCount: 0 Mar 12 11:06:18.364: //-1//AFW_:/AFW_M_DataList_Free: Mar 12 11:06:18.364: //54//AFW_:/AFW_ExecEnv_CloseIfDone: Cmd Count: 4 Mar 12 11:06:18.364: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event(0) Mar 12 11:06:18.364: //-1//AFW_:/AFW_Class_Allocate: Malloc Data Space: Event(Size=2864) Mar 12 11:06:18.364: //-1//AFW_:/AFW_DataList_New: Mar 12 11:06:18.364: //-1//AFW_:/AFW_Class_Allocate: Router# Router#