topic Re: What is the operation of callInfo(rerouteMode) ? in Call Control

What is the operation of callInfo(rerouteMode) ?

paolo bevilacqua — Thu, 06 Aug 2015 15:44:14 GMT

I cannot have this working as described. I set it "none" in conjunction with "mode rotary", but when calling a number that has call forward, there is no notification to the script, call setup continues toward the CF destination.

That is a SIP call and the message "moved temporarily" is received normally.

Is the element name "rerouteMode" the correct one? On page 3-77 there is an example as:

set callInfo(rotaryRedirectMode) “ROTARY”

That doesn't work either.

Re: What is the operation of callInfo(rerouteMode) ?

Raghavendra G V — Fri, 07 Aug 2015 05:14:59 GMT

I believe rerouteMode is correct, you can find below description in guide.

– rerouteMode—Possible values are: none / rotary / redirect / redirect_rotary. If not specified, the
value is same as mode. If both this argument and mode are not specified, the default value is
rotary. This parameter does not allow indexing.

You can also find in the logs as below.

*Aug 7 05:09:11.487: //-1//CSPK:/tclSetControlParams: mode(2) = REDIRECT
*Aug 7 05:09:11.487: //13//CSPK:/C_CallSetup_Start: ControlInfo = 0x7824F12C, callInfo = 0x7824F96C, destination[0]=3009
*Aug 7 05:09:11.487: //13//CSPK:/C_CallSetup_Start: configured reroutemode=rotary (1)

Thanks,
Raghavendra

Re: What is the operation of callInfo(rerouteMode) ?

paolo bevilacqua — Fri, 07 Aug 2015 08:38:24 GMT

Problem is, as indicated above, that setting rerouteMode to null has no effect. There is no indication to the script as the manual mentions. At least with IOS 15.14 that I've tried with.

Re: What is the operation of callInfo(rerouteMode) ?

Raghavendra G V — Fri, 07 Aug 2015 10:23:10 GMT

When you say no indication to script means, script did not get ev_setup_done event ?.

could you please share us the logs.

Thanks,

Raghavendra

Re: What is the operation of callInfo(rerouteMode) ?

Raghavendra G V — Fri, 07 Aug 2015 10:50:37 GMT

You can use below infotag which Returns forwarding request information when a call is being forwarded.

infotag get evt_redirect_info {redirectDest | redirectReason | redirectCount | originalDest}

Thanks,
Raghavendra

Re: What is the operation of callInfo(rerouteMode) ?

paolo bevilacqua — Fri, 07 Aug 2015 11:19:17 GMT

You can use below infotag which Returns forwarding request information when a call is being forwarded.

infotag get evt_redirect_info {redirectDest | redirectReason | redirectCount | originalDest}

Accessing this infotag on ev_setup_done always generate an error, either destination has CF set or not.

Aug 7 13:15:41.660: //768//AFW_:/AFW_FSM_Drive: Tcl_Eval to drive FSM inside Tcl modulespace. code=1 code=ERROR

Aug 7 13:15:41.660: TCL script failure

Result:

Aug 7 13:15:41.660: TCL script failure errorInfo:

while executing

"infotag get evt_redirect_info redirectDest"

As mentioned according to the documentation the script is supposed to receive ev_setup_done with a different status code to indicate destination has call forward. That doesn't happen.

Re: What is the operation of callInfo(rerouteMode) ?

Raghavendra G V — Fri, 07 Aug 2015 11:55:43 GMT

I think you should get the status code as "ls_026" when the call is forwarded. What is the status code you got.

Thanks,
Raghavendra

Re: What is the operation of callInfo(rerouteMode) ?

paolo bevilacqua — Fri, 07 Aug 2015 12:29:01 GMT

I think you should get the status code as "ls_026" when the call is forwarded. What is the status code you got.

As explained above already, the status is the one related to the final cal destination, for example answered, busy or no answer. Never ls_026.

Note that the destination gateways correctly sends "SIP moved temporarily" and the local router re--invites to the new destination. But the script is never notified.

Re: What is the operation of callInfo(rerouteMode) ?

Raghavendra G V — Mon, 10 Aug 2015 04:41:01 GMT

What is the status code you got when call is forwarded. Is it possible for you to share the logs.

Thanks,

Raghavendra

Re: What is the operation of callInfo(rerouteMode) ?

paolo bevilacqua — Mon, 10 Aug 2015 08:13:02 GMT

Again fro my answer above:

As explained above already, the status is the one related to the final cal destination, for example answered, busy or no answer. Never ls_026.

Regarding logs they are nothing particular. Just have a script that calls a number with call forwarding and should see that callInfo(rerouteMode) has no effect.

Re: What is the operation of callInfo(rerouteMode) ?

Raghavendra G V — Mon, 10 Aug 2015 10:02:25 GMT

I don't any issues, you can refer below H450 TCL script for rerouteMode Example.

set callInfo(rerouteMode) NONE

https://software.cisco.com/download/release.html?mdfid=277641082&softwareid=283451126&release=2.0.1.0&rellifecycle=&relind=AVAILABLE&reltype=all

Thanks,
Raghavendra

Re: What is the operation of callInfo(rerouteMode) ?

paolo bevilacqua — Mon, 10 Aug 2015 11:09:49 GMT

As mentioned before, I use SIP not H.323 on which H.450 is based.

With SIP, the script is not notified that the destination has set call transfer.

Re: What is the operation of callInfo(rerouteMode) ?

Raghavendra G V — Mon, 10 Aug 2015 11:29:07 GMT

I did try with SIP only, script got notified with status ls_026 and able to get redirect Info.

Thanks,

Raghavendra

Re: What is the operation of callInfo(rerouteMode) ?

paolo bevilacqua — Mon, 10 Aug 2015 12:07:33 GMT

See below log where the script never receives ls_026, yet SIP has sent the redirection info, and the gateway acted on it.

IOS 15.1(4) which is the latest available for ISR routers.

This is the test script It is started with "call application session start xxx zzz"

proc sess {} {

set callInfo(rerouteMode) rotary

leg setup 202 callinfo

}

proc setupDone {} { puts [infotag get evt_status] }

set fsm(I,ev_session_indication) {sess same_state}

set fsm(I,ev_setup_done) {setupDone same_state}

fsm define fsm I

----------- LOG

Aug 10 14:01:37.039: //-1//SERV:/AFW_Service_GetExecEnv: Script Name = test

Aug 10 14:01:37.039: //-1//AFW_:/AFW_Process_New: test

Aug 10 14:01:37.039: //-1//AFW_:/AFW_ExecEnv_New:

Aug 10 14:01:37.039: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetRoot: Execenv = 0x69285BE8

Aug 10 14:01:37.039: //-1//AFW_:/AFW_TclModule_New:

Aug 10 14:01:37.039: //-1//AFW_:/AFW_Process_Lock: pProcess(0x690CCF4C)=1

Aug 10 14:01:37.043: //-1//AFW_:LP:EE69285BE8000:HN1E8BD0B4:/AFW_M_Object_SetExecEnv: ObjCount: 1, CmdPending 0

Aug 10 14:01:37.043: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetScript: Script Name = test,

Aug 10 14:01:37.043: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetScript: Script URI = ftp://10.0.2.1/test-callinfo.tcl

Aug 10 14:01:37.043: //-1//AFW_:EE69285BE8000:/Tcl_Link: Linking script test

Aug 10 14:01:37.047: //-1//ACPK:EE69285BE8000:/AppCommon_SetSecurity: security = undefined

Aug 10 14:01:37.047: //-1//ACPK:EE69285BE8000:/AppCommon_SetEventLog: event-log = unconfigured

Aug 10 14:01:37.047: //-1//TCL :EE69285BE8000:/tcl_FSMObjCmd: fsm define fsm I

Aug 10 14:01:37.051: //-1//AFW_:/AFW_FSM_New:

Aug 10 14:01:37.051: //-1//TCL :EE69285BE8000:/tcl_FSMDefineObjCmd: State Machine: Array fsm: Start State: I

Aug 10 14:01:37.051: //-1//TCL :EE69285BE8000:/tcl_FSMDefineObjCmd: FSM Data structure

Aug 10 14:01:37.051: (I(1), ev_session_indication(198)--(sess)-->(any_state(0))

Aug 10 14:01:37.051: (I(1), ev_setup_done(219)--(setupDone)-->(any_state(0))

Aug 10 14:01:37.051: FSM start state I(1)

Aug 10 14:01:37.051: //-1//AFW_:EE69285BE8000:/Tcl_Link: Script test succesfully linked.

Aug 10 14:01:37.051: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetScript: Num of packTable entries: 22

Aug 10 14:01:37.051: //-1//AFW_:/AFW_Event_New: Event ID: ev_session_indication

Aug 10 14:01:37.051: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_Initiate: Execenv = 0x69285BE8

Aug 10 14:01:37.051: //-1//SERV:/AFW_Service_Process_Space:

Aug 10 14:01:37.051: Process Started

Aug 10 14:01:37.055: //-1//AFW_:/AFW_Process_Register: ccAppInitialize(name: _ManagedAppProcess_test)

Aug 10 14:01:37.055: //-1//AFW_:EE69285BE8000:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED

Aug 10 14:01:37.055: //-1//AFW_:EE69285BE8000:/AFW_Process_GetAppQEvent: Received

Aug 10 14:01:37.055: //-1//AFW_:/AFW_Process_GetAppQEvent: Event[APP_EV_SESSION_START_IND(198)] {

Aug 10 14:01:37.055: //-1//AFW_:/AFW_Process_GetAppQEvent: EXECENV[0x69285BE8][test]

Aug 10 14:01:37.055: //-1//AFW_:/AFW_Process_GetAppQEvent:

Aug 10 14:01:37.055: //-1//AFW_:EE69285BE8000:/AFW_M_Module_GetHandle: Module handle: TclModule_69F32740_0_512479412MOD[TclModule_69F32740_0_512479412] (

Aug 10 14:01:37.055: //-1//AFW_:/AFW_Process_GetAppQEvent: )

Aug 10 14:01:37.059: //-1//AFW_:/AFW_Process_GetAppQEvent: }

Aug 10 14:01:37.059: //-1//AFW_:EE69285BE8000:/AFW_M_TclModule_EventPreProcess:

Aug 10 14:01:37.059: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: TclModule_69F32740_0_512479412 ---> TclModule_69F32740_0_512479412

Aug 10 14:01:37.059: //-1//AFW_:EE69285BE8000:/AFW_M_TclModule_Action:

Aug 10 14:01:37.059: //-1//AFW_:EE69285BE8000:/AFW_TclModule_DefaultEvHandling:

Aug 10 14:01:37.059: //-1//AFW_:EE69285BE8000:/AFW_FSM_Drive: ACTION BEGIN: ------(I[1],ev_session_indication[198])---[sess]------

Aug 10 14:01:37.059: //-1//TCL :EE69285BE8000:/tcl_LegObjCmd: leg setup 202 callinfo

Aug 10 14:01:37.059: //-1//CSPK:EE69285BE8000:/tcl_LegSetupObjCmd: leg setup 202 callinfo

Aug 10 14:01:37.059: //-1//CSPK:EE69285BE8000:/C_CallSetup_Start: ControlInfo = 0x69F1CCEC, callInfo = 0x69F5DCC8, destination[0]=202

Aug 10 14:01:37.059: //-1//CSPK:EE69285BE8000:/C_CallSetup_Start: configured mode=rotary (1)

Aug 10 14:01:37.059: //-1//CSPK:EE69285BE8000:/C_CallSetup_Start: configured reroutemode=rotary (1)

Aug 10 14:01:37.063: //-1//Call:/AFW_CallSetup_New:

Aug 10 14:01:37.063: //-1//AFW_:/AFW_FSM_New:

Aug 10 14:01:37.063: //-1//AFW_:LP:EE69285BE8000:HN1E8BD0CC:/AFW_M_Object_SetExecEnv: ObjCount: 2, CmdPending 0

Aug 10 14:01:37.063: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 1

Aug 10 14:01:37.063: //-1//AFW_:EE69285BE8000:/AFW_Object_AddListener: adding Module TclModule as listener

Aug 10 14:01:37.063: //-1//AFW_:EE69285BE8000:/AFW_M_Module_GetHandle: Module handle: CallSetup_69137538_0_512479436

Aug 10 14:01:37.063: //-1//Call:EE69285BE8000:/AFW_CallSetup_AddDest: 202 index 0

Aug 10 14:01:37.063: //-1//Call:EE69285BE8000:/AFW_M_CallSetup_Initiate:

Aug 10 14:01:37.063: //-1//Call:EE69285BE8000:/CS_UpdateMLPPInfo: ServiceDomain:[none (0)] DomainIdentifier:[000000] PrecedenceLevel:[-1 (PRECEDENCE_LEVEL_NONE)] NormalizedPrecedence:[0 (INTERNAL_PRECEDENCE_0)] Preempt Hunt Not Set

Aug 10 14:01:37.063: //-1//Call:EE69285BE8000:/CallSetupInitiate:

Aug 10 14:01:37.063: //-1//Call:EE69285BE8000:/CS_Placecall:

Aug 10 14:01:37.063: //-1//Dest:/AFW_Destination_New:

Aug 10 14:01:37.063: //-1//AFW_:/AFW_FSM_New:

Aug 10 14:01:37.063: //-1//AFW_:LP:EE69285BE8000:HN1E8BD0CC:/AFW_M_Object_SetExecEnv: ObjCount: 3, CmdPending 1

Aug 10 14:01:37.063: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 2

Aug 10 14:01:37.067: //-1//AFW_:EE69285BE8000:/AFW_Object_AddListener: adding Module CallSetup as listener

Aug 10 14:01:37.067: //-1//AFW_:EE69285BE8000:/AFW_M_Module_GetHandle: Module handle: Destination_69188FD4_0_512479436

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/AFW_Destination_AddDest:

Aug 10 14:01:37.067: //-1//Dest:/AFW_Destination_AddDest: adding destination "202"

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/AFW_M_Destination_Initiate:

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/AFW_M_Destination_Initiate: Outgoing guid : 62ECE0A7.3E8E11E5.87A8C175.851B1C9E

Aug 10 14:01:37.067: Incoming_guid : 00000000.00000000.00000000.00000000

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/AFW_M_Destination_Initiate: Outgoing gcid : 00000000.00000000.00000000.00000000

Aug 10 14:01:37.067: Incoming_gcid : 00000000.00000000.00000000.00000000

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/DestUpdateMLPPInfo: ServiceDomain:[none (0)] DomainIdentifier:[000000] PrecedenceLevel:[-1 (PRECEDENCE_LEVEL_NONE)] NormalizedPrecedence:[-1 (PRECEDENCE_LEVEL_NONE)] Preempt Hunt Not Set

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/DestSetupInitiate:

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/DestAddRerouteSetupInfo:

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/DestAddTransferSetupInfo:

Aug 10 14:01:37.067: //-1//AFW_:/AFW_Util_CopyCallDataToCallInfo: copied 202

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/DestMatchDialPeer:

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/DestMatchDialPeer: src carrier id:, tgt carrier id:

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/DestQueuePeers: Matched peers:

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/DestPeerItemUpdatePreemptInfo:

Aug 10 14:01:37.067: //-1//Dest:EE69285BE8000:/DestPeerItemResetLPCORInfo:

Aug 10 14:01:37.067: //-1//Dest:/DestQueuePeers: 200

Aug 10 14:01:37.067: //-1//Dest:/DestQueuePeers: , Total(1)

Aug 10 14:01:37.071: //-1//Dest:EE69285BE8000:/DestDialPeerRotary:

Aug 10 14:01:37.071: //-1//Dest:EE69285BE8000:/DestOutboundCallUsingPeer: dest(202), numexpDest(202), numDestDigits(2)

Aug 10 14:01:37.071: //-1//Dest:EE69285BE8000:/DestOutboundCallUsingPeer: prefix(.55), peer tag(200)

Aug 10 14:01:37.071: //-1//Dest:EE69285BE8000:/DestUpdatePreemptSetupInfo:

Aug 10 14:01:37.071: //-1//AFW_:/AFW_Util_RemovePreemptInfoFromContainer: Failed to remove mlppSetupInfo from TD container

Aug 10 14:01:37.071: //-1//Dest:EE69285BE8000:/DestDialPeerFilter:

Aug 10 14:01:37.071: //-1//Dest:EE69285BE8000:/DestDialPeerFilter: Checking peer [200]

Aug 10 14:01:37.071: //-1//Dest:EE69285BE8000:/DestPeerFilterRouteCode: Route Code not available

Aug 10 14:01:37.071: //-1//Dest:/DestOutboundCallUsingPeer: Outgoing Tag(200) calling[] called[202]

Aug 10 14:01:37.071: //-1//Dest:EE69285BE8000:/DestCheckTeleUnassBusy:

Aug 10 14:01:37.071: //-1//Dest:EE69285BE8000:/DestHandleLPCOR:

Aug 10 14:01:37.071: //-1//Dest:EE69285BE8000:/DestSetup:

Aug 10 14:01:37.071: //-1//AFW_:/AFW_Leg_GetTypeDetail: ***ERROR*** pLeg is NULL

Aug 10 14:01:37.071: //-1//AFW_:/AFW_Util_SaveRawMsg:

Aug 10 14:01:37.071: //-1//AFW_:/AFW_Leg_New:

Aug 10 14:01:37.071: //1073/62ECE0A787A8/AFW_:/AFW_Leg_NewSetupRequest: ccCallSetupRequest done

Aug 10 14:01:37.071: //1073/62ECE0A787A8/AFW_:/AFW_M_Leg_SetExecEnv:

Aug 10 14:01:37.075: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 3

Aug 10 14:01:37.075: //-1/62ECE0A787A8/AFW_:LP:EE69285BE8000:LG1073:/AFW_M_Object_SetExecEnv: ObjCount: 4, CmdPending 3

Aug 10 14:01:37.075: //1073/62ECE0A787A8/AFW_:/AFW_Object_AddListener: adding Module Destination as listener

Aug 10 14:01:37.075: //1073/62ECE0A787A8/AFW_:/AFW_M_Leg_GetHandle: Leg handle: LEG_1073

Aug 10 14:01:37.075: //1073/62ECE0A787A8/AFW_:/AFW_Leg_UpdateStats: Updating stats for ID 12A type 3

Aug 10 14:01:37.075: //-1//Dest:EE69285BE8000:/DestSetup: Destination setup success

Aug 10 14:01:37.075: //-1//Dest:EE69285BE8000:/AFW_M_Destination_Initiate: attempting call to destination 202

Aug 10 14:01:37.075: //-1//Call:EE69285BE8000:/CS_Placecall: Call placed to 202 index 0

Aug 10 14:01:37.075: //-1//AFW_:EE69285BE8000:/AFW_FSM_Drive: ACTION END: -------------(I[1])---------------

Aug 10 14:01:37.075: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: TclModule_69F32740_0_512479412 ---> TclModule_69F32740_0_512479412

Aug 10 14:01:37.075: //-1//AFW_:EE69285BE8000:/AFW_M_Event_Free:

Aug 10 14:01:37.075: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_CloseIfDone: Cmd Count: 3

Aug 10 14:01:37.075: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 14:01:37.075: //-1//AFW_:/AFW_M_Event_Free:

Aug 10 14:01:37.075: //-1//AFW_:/AFW_M_Event_Free: Null or invalid event context: for event APP_EV_NULL

Aug 10 14:01:37.083: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 14:01:37.083: //1073/62ECE0A787A8/AFW_:/AFW_Process_GetCcqEvent: Received

Aug 10 14:01:37.087: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_PROCEEDING(31)] {

Aug 10 14:01:37.087: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x69285BE8][test]

Aug 10 14:01:37.087: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[1073][LEG_OUTINIT(7)][Cause(0)]

Aug 10 14:01:37.087: //-1//AFW_:/AFW_Process_GetCcqEvent: }

Aug 10 14:01:37.087: //1073/62ECE0A787A8/SSIN:/AFW_SS_MapEvent:

Aug 10 14:01:37.087: //-1//SSIN:/AFW_SS_SIP_MapEvent:

Aug 10 14:01:37.087: //1073/62ECE0A787A8/AFW_:/AFW_M_Leg_EventPreProcess: LEG[1073 ][LEG_OUTINIT(7)][Cause(0)]

Aug 10 14:01:37.087: //1073/62ECE0A787A8/AFW_:/AFW_Object_WalkListeners:

Aug 10 14:01:37.087: //1073/62ECE0A787A8/AFW_:/AFW_M_Object_ShowListeners: START

Aug 10 14:01:37.087: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_69188FD4_0_512479436] (

Aug 10 14:01:37.087: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[1073][LEG_OUTINIT(7)][Cause(0)]

Aug 10 14:01:37.087: //-1//AFW_:/AFW_M_Object_ShowListeners: )

Aug 10 14:01:37.087: //1073/62ECE0A787A8/AFW_:/AFW_M_Object_ShowListeners: END

Aug 10 14:01:37.087: //1073/62ECE0A787A8/AFW_:/AFW_Object_WalkListeners: Entering Module : Destination

Aug 10 14:01:37.087: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: TclModule_69F32740_0_512479412 ---> Destination_69188FD4_0_512479436

Aug 10 14:01:37.087: //-1//Dest:EE69285BE8000:/AFW_M_Destination_Action:

Aug 10 14:01:37.087: //-1//Dest:EE69285BE8000:/AFW_Destination_Action:

Aug 10 14:01:37.087: //-1//Dest:EE69285BE8000:/OB_FSM_Drive:

Aug 10 14:01:37.087: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: Destination_69188FD4_0_512479436 ---> Destination_69188FD4_0_512479436

Aug 10 14:01:37.087: //-1//AFW_:EE69285BE8000:/AFW_FSM_Drive: ACTION BEGIN: ------(OB_STATE_SETTING[3],ev_proceeding[31])---[C_Action]------

Aug 10 14:01:37.087: //-1//Dest:EE69285BE8000:/OB_Setting_Proceeding:

Aug 10 14:01:37.087: //-1//AFW_:EE69285BE8000:/AFW_FSM_Drive: ACTION END: -------------(OB_STATE_SETTING[3])---------------

Aug 10 14:01:37.087: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: Destination_69188FD4_0_512479436 ---> Destination_69188FD4_0_512479436

Aug 10 14:01:37.087: //-1//Dest:EE69285BE8000:/IW_FSM_Drive:

Aug 10 14:01:37.087: //-1//Dest:EE69285BE8000:/IW_FSM_Drive: No interworking leg, no need to interwork event

Aug 10 14:01:37.087: //-1//Dest:EE69285BE8000:/DestIsEventNotified:

Aug 10 14:01:37.087: //-1//Dest:EE69285BE8000:/DestComplete: peer #:200 IW State IW_STATE_INIT, OB State OB_STATE_SETTING

Aug 10 14:01:37.087: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: Destination_69188FD4_0_512479436 ---> TclModule_69F32740_0_512479412

Aug 10 14:01:37.091: //1073/62ECE0A787A8/AFW_:/AFW_M_Event_Free:

Aug 10 14:01:37.091: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_CloseIfDone: Cmd Count: 3

Aug 10 14:01:37.091: //1073/62ECE0A787A8/SIP/Msg/ccsipDisplayMsg:

Sent:

INVITE sip:202@10.160.3.55:5060 SIP/2.0

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28824B4

From: <sip:10.160.3.56>;tag=1E8BD0E0-387

To: <sip:202@10.160.3.55>

Date: Mon, 10 Aug 2015 12:01:37 GMT

Call-ID: 62EF51DF-3E8E11E5-87ABC175-851B1C9E@10.160.3.56

Supported: 100rel,timer,resource-priority,replaces,sdp-anat

Min-SE: 1800

Cisco-Guid: 1659691175-1049498085-2275983733-2233146526

User-Agent: Cisco-SIPGateway/IOS-12.x

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

CSeq: 101 INVITE

Max-Forwards: 70

Timestamp: 1439208097

Contact: <sip:10.160.3.56:5060>

Expires: 180

Allow-Events: telephone-event

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 268

v=0

o=CiscoSystemsSIP-GW-UserAgent 4364 1368 IN IP4 10.160.3.56

s=SIP Call

c=IN IP4 10.160.3.56

t=0 0

m=audio 17608 RTP/AVP 0 101 19

c=IN IP4 10.160.3.56

a=rtpmap:0 PCMU/8000

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=rtpmap:19 CN/8000

a=ptime:20

Aug 10 14:01:37.103: //1073/62ECE0A787A8/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28824B4

From: <sip:10.160.3.56>;tag=1E8BD0E0-387

To: <sip:202@10.160.3.55>

Date: Mon, 10 Aug 2015 12:01:37 GMT

Call-ID: 62EF51DF-3E8E11E5-87ABC175-851B1C9E@10.160.3.56

Timestamp: 1439208097

CSeq: 101 INVITE

Allow-Events: telephone-event

Server: Cisco-SIPGateway/IOS-12.x

Content-Length: 0

Aug 10 14:01:37.103: //1073/62ECE0A787A8/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 302 Moved Temporarily

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28824B4

From: <sip:10.160.3.56>;tag=1E8BD0E0-387

To: <sip:202@10.160.3.55>;tag=1E5AF478-22BB

Date: Mon, 10 Aug 2015 12:01:37 GMT

Call-ID: 62EF51DF-3E8E11E5-87ABC175-851B1C9E@10.160.3.56

Timestamp: 1439208097

CSeq: 101 INVITE

Allow-Events: telephone-event

Server: Cisco-SIPGateway/IOS-12.x

Diversion: <sip:202@10.160.3.55>;reason=unconditional;counter=1

Contact: <sip:203@10.160.3.55>

Content-Length: 0

Aug 10 14:01:37.111: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 14:01:37.111: //1073/62ECE0A787A8/AFW_:/AFW_Process_GetCcqEvent: Received

Aug 10 14:01:37.111: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_FEATURE(38)] {

Aug 10 14:01:37.111: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x69285BE8][test]

Aug 10 14:01:37.111: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[1073][LEG_OUTPROCEED(8)][Cause(0)]

Aug 10 14:01:37.111: //-1//AFW_:/AFW_Process_GetCcqEvent: }

Aug 10 14:01:37.111: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

Aug 10 14:01:37.111: //1073/62ECE0A787A8/AFW_:/AFW_M_Leg_EventPreProcess: LEG[1073 ][LEG_OUTPROCEED(8)][Cause(0)]

Aug 10 14:01:37.111: //1073/62ECE0A787A8/AFW_:/AFW_Object_WalkListeners:

Aug 10 14:01:37.111: //1073/62ECE0A787A8/AFW_:/AFW_M_Object_ShowListeners: START

Aug 10 14:01:37.111: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_69188FD4_0_512479436] (

Aug 10 14:01:37.111: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[1073][LEG_OUTPROCEED(8)][Cause(0)]

Aug 10 14:01:37.111: //-1//AFW_:/AFW_M_Object_ShowListeners: )

Aug 10 14:01:37.111: //1073/62ECE0A787A8/AFW_:/AFW_M_Object_ShowListeners: END

Aug 10 14:01:37.111: //1073/62ECE0A787A8/AFW_:/AFW_Object_WalkListeners: Entering Module : Destination

Aug 10 14:01:37.111: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: NULL ---> Destination_69188FD4_0_512479436

Aug 10 14:01:37.111: //-1//Dest:EE69285BE8000:/AFW_M_Destination_Action:

Aug 10 14:01:37.115: //-1//Dest:EE69285BE8000:/AFW_Destination_Action:

Aug 10 14:01:37.115: //-1//Dest:EE69285BE8000:/OB_FSM_Drive:

Aug 10 14:01:37.115: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: Destination_69188FD4_0_512479436 ---> Destination_69188FD4_0_512479436

Aug 10 14:01:37.115: //-1//AFW_:EE69285BE8000:/AFW_FSM_Drive: ACTION BEGIN: ------(OB_STATE_SETTING[3],ev_feature[38])---[C_Action]------

Aug 10 14:01:37.115: //-1//Dest:EE69285BE8000:/OB_Ignore: IGNORING EVENT

Aug 10 14:01:37.115: //-1//AFW_:EE69285BE8000:/AFW_FSM_Drive: ACTION END: -------------(OB_STATE_SETTING[3])---------------

Aug 10 14:01:37.115: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: Destination_69188FD4_0_512479436 ---> Destination_69188FD4_0_512479436

Aug 10 14:01:37.115: //-1//Dest:EE69285BE8000:/IW_FSM_Drive:

Aug 10 14:01:37.115: //-1//Dest:EE69285BE8000:/IW_FSM_Drive: No interworking leg, no need to interwork event

Aug 10 14:01:37.115: //-1//Dest:EE69285BE8000:/DestIsEventNotified:

Aug 10 14:01:37.115: //-1//Dest:EE69285BE8000:/DestComplete: peer #:200 IW State IW_STATE_INIT, OB State OB_STATE_SETTING

Aug 10 14:01:37.115: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: Destination_69188FD4_0_512479436 ---> NULL

Aug 10 14:01:37.115: //1073/62ECE0A787A8/AFW_:/AFW_M_Event_Free:

Aug 10 14:01:37.115: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_CloseIfDone: Cmd Count: 3

Aug 10 14:01:37.115: //1073/62ECE0A787A8/SIP/Msg/ccsipDisplayMsg:

Sent:

ACK sip:202@10.160.3.55:5060 SIP/2.0

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28824B4

From: <sip:10.160.3.56>;tag=1E8BD0E0-387

To: <sip:202@10.160.3.55>;tag=1E5AF478-22BB

Date: Mon, 10 Aug 2015 12:01:37 GMT

Call-ID: 62EF51DF-3E8E11E5-87ABC175-851B1C9E@10.160.3.56

Max-Forwards: 70

CSeq: 101 ACK

Allow-Events: telephone-event

Content-Length: 0

Aug 10 14:01:37.119: //1073/62ECE0A787A8/SIP/Msg/ccsipDisplayMsg:

Sent:

INVITE sip:203@10.160.3.55:5060 SIP/2.0

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28912FF

From: <sip:10.160.3.56>;tag=1E8BD0F8-21D

To: <sip:202@10.160.3.55>

Date: Mon, 10 Aug 2015 12:01:37 GMT

Call-ID: 62EF51DF-3E8E11E5-87ABC175-851B1C9E@10.160.3.56

Supported: 100rel,timer,resource-priority,replaces,sdp-anat

Min-SE: 1800

Cisco-Guid: 1659691175-1049498085-2275983733-2233146526

User-Agent: Cisco-SIPGateway/IOS-12.x

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

CSeq: 102 INVITE

Max-Forwards: 70

Timestamp: 1439208097

Contact: <sip:10.160.3.56:5060>

Diversion: <sip:202@10.160.3.55>;reason=unconditional;counter=1

Expires: 180

Allow-Events: telephone-event

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 268

v=0

o=CiscoSystemsSIP-GW-UserAgent 4364 1368 IN IP4 10.160.3.56

s=SIP Call

c=IN IP4 10.160.3.56

t=0 0

m=audio 17608 RTP/AVP 0 101 19

c=IN IP4 10.160.3.56

a=rtpmap:0 PCMU/8000

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=rtpmap:19 CN/8000

a=ptime:20

Aug 10 14:01:37.131: //1073/62ECE0A787A8/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28912FF

From: <sip:10.160.3.56>;tag=1E8BD0F8-21D

To: <sip:202@10.160.3.55>

Date: Mon, 10 Aug 2015 12:01:37 GMT

Call-ID: 62EF51DF-3E8E11E5-87ABC175-851B1C9E@10.160.3.56

Timestamp: 1439208097

CSeq: 102 INVITE

Allow-Events: telephone-event

Server: Cisco-SIPGateway/IOS-12.x

Content-Length: 0

Aug 10 14:01:37.131: //1073/62ECE0A787A8/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 503 Service Unavailable

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28912FF

From: <sip:10.160.3.56>;tag=1E8BD0F8-21D

To: <sip:202@10.160.3.55>;tag=1E5AF494-12AB

Date: Mon, 10 Aug 2015 12:01:37 GMT

Call-ID: 62EF51DF-3E8E11E5-87ABC175-851B1C9E@10.160.3.56

Timestamp: 1439208097

CSeq: 102 INVITE

Allow-Events: telephone-event

Server: Cisco-SIPGateway/IOS-12.x

Diversion: <sip:203@10.160.3.55>;reason=unconditional;counter=2

Diversion: <sip:202@10.160.3.55>;reason=unconditional;counter=1

Content-Length: 0

Aug 10 14:01:37.135: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 14:01:37.135: //1073/62ECE0A787A8/AFW_:/AFW_Process_GetCcqEvent: Received

Aug 10 14:01:37.135: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DISCONNECTED(20)] {

Aug 10 14:01:37.135: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x69285BE8][test]

Aug 10 14:01:37.135: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[1073][LEG_OUTPROCEED(8)][Cause(0)]

Aug 10 14:01:37.135: //-1//AFW_:/AFW_Process_GetCcqEvent: }

Aug 10 14:01:37.135: //1073/62ECE0A787A8/SSIN:/AFW_SS_MapEvent:

Aug 10 14:01:37.135: //-1//SSIN:/AFW_SS_SIP_MapEvent:

Aug 10 14:01:37.135: //1073/62ECE0A787A8/AFW_:/AFW_Object_WalkListeners:

Aug 10 14:01:37.135: //1073/62ECE0A787A8/AFW_:/AFW_M_Object_ShowListeners: START

Aug 10 14:01:37.135: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_69188FD4_0_512479436] (

Aug 10 14:01:37.135: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[1073][LEG_OUTPROCEED(8)][Cause(63)]

Aug 10 14:01:37.139: //-1//AFW_:/AFW_M_Object_ShowListeners: )

Aug 10 14:01:37.139: //1073/62ECE0A787A8/AFW_:/AFW_M_Object_ShowListeners: END

Aug 10 14:01:37.139: //1073/62ECE0A787A8/AFW_:/AFW_Object_WalkListeners: Entering Module : Destination

Aug 10 14:01:37.139: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: NULL ---> Destination_69188FD4_0_512479436

Aug 10 14:01:37.139: //-1//Dest:EE69285BE8000:/AFW_M_Destination_Action:

Aug 10 14:01:37.139: //-1//Dest:EE69285BE8000:/AFW_Destination_Action:

Aug 10 14:01:37.139: //-1//Dest:EE69285BE8000:/OB_FSM_Drive:

Aug 10 14:01:37.139: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: Destination_69188FD4_0_512479436 ---> Destination_69188FD4_0_512479436

Aug 10 14:01:37.139: //-1//AFW_:EE69285BE8000:/AFW_FSM_Drive: ACTION BEGIN: ------(OB_STATE_SETTING[3],ev_disconnected[20])---[C_Action]------

Aug 10 14:01:37.139: //-1//Dest:EE69285BE8000:/OB_Setting_Disconnected:

Aug 10 14:01:37.139: //-1//Dest:EE69285BE8000:/OBDiscContinue:

Aug 10 14:01:37.139: //-1//Dest:EE69285BE8000:/resetAppAlertTimer:

Aug 10 14:01:37.139: //-1//Dest:EE69285BE8000:/Dest_AAA_CheckAccounting:

Aug 10 14:01:37.139: //-1//Dest:EE69285BE8000:/Dest_AAA_CheckAccounting: accounting to be enabled for callID=1073

Aug 10 14:01:37.139: //1073/62ECE0A787A8/AFW_:/AFW_Leg_Disconnect: Disconnecting Leg: LEG_1073

Aug 10 14:01:37.139: //1073/62ECE0A787A8/AFW_:/AFW_Leg_Disconnect: Disconnecting Leg: LEG_1073, Cause 63

Aug 10 14:01:37.139: //1073/62ECE0A787A8/AFW_:/AFW_Leg_UpdateStats: Updating stats for ID 12A type 2

Aug 10 14:01:37.139: //-1//Dest:/DestStatusFromDiscCause: mapped "service or option not available unspecified (63)"(63) to DEST_NUMBER_BLOCKED(18)

Aug 10 14:01:37.143: //-1//AFW_:EE69285BE8000:/AFW_FSM_Drive: ACTION END: -------------(OB_STATE_DISCONNECTING[6])---------------

Aug 10 14:01:37.143: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: Destination_69188FD4_0_512479436 ---> Destination_69188FD4_0_512479436

Aug 10 14:01:37.143: //-1//Dest:EE69285BE8000:/IW_FSM_Drive:

Aug 10 14:01:37.143: //-1//Dest:EE69285BE8000:/IW_FSM_Drive: No interworking leg, no need to interwork event

Aug 10 14:01:37.143: //-1//Dest:EE69285BE8000:/DestIsEventNotified:

Aug 10 14:01:37.143: //-1//Dest:EE69285BE8000:/DestComplete: peer #:200 IW State IW_STATE_INIT, OB State OB_STATE_DISCONNECTING

Aug 10 14:01:37.143: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: Destination_69188FD4_0_512479436 ---> NULL

Aug 10 14:01:37.143: //1073/62ECE0A787A8/AFW_:/AFW_M_Event_Free:

Aug 10 14:01:37.143: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_CloseIfDone: Cmd Count: 3

Aug 10 14:01:37.147: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 14:01:37.147: //1073/62ECE0A787A8/AFW_:/AFW_Process_GetCcqEvent: Received

Aug 10 14:01:37.147: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_DISCONNECT_DONE(21)] {

Aug 10 14:01:37.147: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x69285BE8][test]

Aug 10 14:01:37.147: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[1073][LEG_OUTDISCONNECTING(11)][Cause(63)]

Aug 10 14:01:37.147: //-1//AFW_:/AFW_Process_GetCcqEvent: }

Aug 10 14:01:37.147: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

Aug 10 14:01:37.147: //1073/62ECE0A787A8/AFW_:/AFW_Object_WalkListeners:

Aug 10 14:01:37.147: //1073/62ECE0A787A8/AFW_:/AFW_M_Object_ShowListeners: START

Aug 10 14:01:37.147: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_69188FD4_0_512479436] (

Aug 10 14:01:37.147: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[1073][LEG_DISCONNECTED(12)][Cause(63)]

Aug 10 14:01:37.147: //-1//AFW_:/AFW_M_Object_ShowListeners: )

Aug 10 14:01:37.147: //1073/62ECE0A787A8/AFW_:/AFW_M_Object_ShowListeners: END

Aug 10 14:01:37.147: //1073/62ECE0A787A8/AFW_:/AFW_Object_WalkListeners: Entering Module : Destination

Aug 10 14:01:37.147: //1073/62ECE0A787A8/AFW_:/AFW_Object_RemoveListener:

Aug 10 14:01:37.147: //-1//AFW_:EE69285BE8000:/AFW_Module_UnListen: NumObjects: 0

Aug 10 14:01:37.147: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: NULL ---> Destination_69188FD4_0_512479436

Aug 10 14:01:37.147: //-1//Dest:EE69285BE8000:/AFW_M_Destination_Action:

Aug 10 14:01:37.147: //-1//Dest:EE69285BE8000:/AFW_Destination_Action:

Aug 10 14:01:37.147: //-1//Dest:EE69285BE8000:/OB_FSM_Drive:

Aug 10 14:01:37.147: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: Destination_69188FD4_0_512479436 ---> Destination_69188FD4_0_512479436

Aug 10 14:01:37.151: //-1//AFW_:EE69285BE8000:/AFW_FSM_Drive: ACTION BEGIN: ------(OB_STATE_DISCONNECTING[6],ev_disconnect_done[21])---[C_Action]------

Aug 10 14:01:37.151: //-1//Dest:EE69285BE8000:/OB_Disconnecting_DiscDone:

Aug 10 14:01:37.151: //-1//Dest:EE69285BE8000:/DestDialPeerRotary:

Aug 10 14:01:37.151: //-1//Dest:EE69285BE8000:/OB_Disconnecting_DiscDone: no more dialpeers or all dialpeers failed

Aug 10 14:01:37.151: //-1//AFW_:EE69285BE8000:/AFW_FSM_Drive: ACTION END: -------------(OB_STATE_DONE[8])---------------

Aug 10 14:01:37.151: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: Destination_69188FD4_0_512479436 ---> Destination_69188FD4_0_512479436

Aug 10 14:01:37.151: //-1//Dest:EE69285BE8000:/IW_FSM_Drive:

Aug 10 14:01:37.151: //-1//Dest:EE69285BE8000:/IW_FSM_Drive: No interworking leg, no need to interwork event

Aug 10 14:01:37.151: //-1//Dest:EE69285BE8000:/DestIsEventNotified:

Aug 10 14:01:37.151: //-1//Dest:EE69285BE8000:/DestComplete: peer #:200 IW State IW_STATE_INIT, OB State OB_STATE_DONE

Aug 10 14:01:37.151: //-1//Dest:EE69285BE8000:/DestUpdateMLPPCause: status=18, cause=63, prUserStat=0, prTrunkStat=0

Aug 10 14:01:37.151: //-1//AFW_:/AFW_Event_New: Event ID: ev_destination_done

Aug 10 14:01:37.151: //-1//AFW_:EE69285BE8000:/AFW_Module_ReturnArgEv:

Aug 10 14:01:37.151: //-1//Dest:EE69285BE8000:/DestReturn: Destination Returning(ds_018 Status DEST_NUMBER_BLOCKED)

Aug 10 14:01:37.151: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: Destination_69188FD4_0_512479436 ---> NULL

Aug 10 14:01:37.151: //1073/62ECE0A787A8/AFW_:/AFW_Object_WalkListeners:

Aug 10 14:01:37.151: //1073/62ECE0A787A8/AFW_:/AFW_M_Object_ShowListeners: START

Aug 10 14:01:37.151: //1073/62ECE0A787A8/AFW_:/AFW_M_Object_ShowListeners: END

Aug 10 14:01:37.151: //1073/62ECE0A787A8/AFW_:/AFW_M_Event_Free:

Aug 10 14:01:37.151: //1073/62ECE0A787A8/AFW_:/AFW_M_Event_Free: CC_EV_CALL_DISCONNECT_DONE for a Leg: LEG_1073

Aug 10 14:01:37.151: //1073/62ECE0A787A8/AFW_:/AFW_Object_RemoveAllListener:

Aug 10 14:01:37.151: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_DecrNPendingCmd: PendingCmdCount: 2

Aug 10 14:01:37.151: //-1//AFW_:/AFW_M_Object_UnSetExecEnv: ObjCount: 3, CmdPending 2

Aug 10 14:01:37.151: //1073/62ECE0A787A8/AFW_:/AFW_M_Event_Free: ExecEnv objCount: 3

Aug 10 14:01:37.151: //1073/62ECE0A787A8/AFW_:/AFW_M_Leg_Free:

Aug 10 14:01:37.151: //1073/62ECE0A787A8/AFW_:/AFW_M_Leg_Free: LEG[1073 ][LEG_DISCONNECTED(12)][Cause(63)]

Aug 10 14:01:37.151: //1073/62ECE0A787A8/AFW_:/decrementDialPeerCallStats: Decrementing call-stat to [0], dial-peer [200]

Aug 10 14:01:37.151: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_CloseIfDone: Cmd Count: 2

Aug 10 14:01:37.155: //-1//AFW_:EE69285BE8000:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED

Aug 10 14:01:37.155: //-1//AFW_:EE69285BE8000:/AFW_Process_GetPriorityQEvent: Received

Aug 10 14:01:37.155: //-1//AFW_:/AFW_Process_GetPriorityQEvent: Event[APP_EV_DESTINATION_DONE(221)] {

Aug 10 14:01:37.155: //-1//AFW_:/AFW_Process_GetPriorityQEvent: EXECENV[0x69285BE8][test]

Aug 10 14:01:37.155: //-1//AFW_:/AFW_Process_GetPriorityQEvent: MOD[Destination_69188FD4_0_512479436] (

Aug 10 14:01:37.155: //-1//AFW_:/AFW_Process_GetPriorityQEvent: )

Aug 10 14:01:37.155: //-1//AFW_:/AFW_Process_GetPriorityQEvent: }

Aug 10 14:01:37.155: //-1//Dest:EE69285BE8000:/AFW_M_Destination_EventPreProcess:

Aug 10 14:01:37.155: //-1//AFW_:EE69285BE8000:/AFW_Object_WalkListeners:

Aug 10 14:01:37.155: //-1//AFW_:EE69285BE8000:/AFW_M_Object_ShowListeners: START

Aug 10 14:01:37.155: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[CallSetup_69137538_0_512479436] (

Aug 10 14:01:37.155: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_69188FD4_0_512479436] (

Aug 10 14:01:37.155: //-1//AFW_:/AFW_M_Object_ShowListeners: )

Aug 10 14:01:37.155: //-1//AFW_:EE69285BE8000:/AFW_M_Object_ShowListeners: END

Aug 10 14:01:37.155: //-1//AFW_:EE69285BE8000:/AFW_Object_WalkListeners: Entering Module : CallSetup

Aug 10 14:01:37.155: //-1//AFW_:EE69285BE8000:/AFW_Object_RemoveListener:

Aug 10 14:01:37.155: //-1//AFW_:EE69285BE8000:/AFW_Module_UnListen: NumObjects: 0

Aug 10 14:01:37.155: //-1//AFW_:EE69285BE8000:/AFW_ExecEnv_SetModuleScope: NULL ---> CallSetup_69137538_0_512479436

Aug 10 14:01:37.155: //-1//Call:EE69285BE8000:/AFW_M_CallSetup_Action:

Aug 10 14:01:37.155: //-1//AFW_:EE69285BE8000:/AFW_FSM_Drive: ACTION BEGIN: ------(S_PLACECALL[2],ev_destination_done[221])---[C_Action]------

Aug 10 14:01:37.155: //-1//Call:EE69285BE8000:/CS_Placecall_DestDone:

Aug 10 14:01:37.155: //-1//Call:EE69285BE8000:/CS_DestDone_CapturePreemptStatus: PreemptErrorCode 0; Play prompt none

Aug 10 14:01:37.155: //-1//AFW_:EE69285BE8000:/AFW_FSM_Drive: ACTION END: -------------(S_DONE[13])---------------

Aug 10 14:01:37.155: //-1//AFW_:/AFW_Event_New: Event ID: ev_setup_done

Aug 10 14:01:37.155: //-1//AFW_:EE69285BE8000:/AFW_Module_ReturnArgEv:

Aug 10 14:01:37.159: //-1//Call:EE69285BE8000:/CS_Complete:

Aug 10 14:01:37.175: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 14:01:37.175: //-1//AFW_:/AFW_M_Event_Free:

Aug 10 14:01:37.175: //-1//AFW_:/AFW_M_Event_Free: Null or invalid event context: for event APP_EV_NULL

Re: What is the operation of callInfo(rerouteMode) ?

Raghavendra G V — Mon, 10 Aug 2015 12:30:26 GMT

You need to use as below.

proc sess {} {

set callInfo(rerouteMode) NONE

leg setup 202 callInfo

}

Thanks,

Raghavendra

Re: What is the operation of callInfo(rerouteMode) ?

paolo bevilacqua — Mon, 10 Aug 2015 13:39:07 GMT

As I have mentioned in my opening post, I'm using "none".

The script above has "rotary" for the purpose of generating a comparison with NONE.

Here again the logs when using NONE. They are the same as when using rotary".

Status code never indicates call forward.

Aug 10 15:32:46.792: //-1//SERV:/AFW_Service_GetExecEnv: Script Name = test

Aug 10 15:32:46.792: //-1//SERV:/AFW_Service_GetExecEnv: Using Cached ExecEnv

Aug 10 15:32:46.792: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetRoot: Execenv = 0x67B8F67C

Aug 10 15:32:46.792: //-1//AFW_:/AFW_M_TclModule_NewDup:

Aug 10 15:32:46.792: //-1//AFW_:HN1EDD1CD4:/AFW_M_TclModule_Free:

Aug 10 15:32:46.796: //-1//AFW_:HN1EDD1CD4:/AFW_M_Module_GetHandle: Module handle: TclModule_69F322F0_0_517807316MOD[TclModule_69F322F0_0_517807316] ( )

Aug 10 15:32:46.796: //-1//AFW_:/AFW_M_FSM_Free:

Aug 10 15:32:46.796: //-1//AFW_:/AFW_Process_Lock: pProcess(0x690CCFCC)=1

Aug 10 15:32:46.796: //-1//AFW_:LP:EE67B8F67C000:HN1EDF48E4:/AFW_M_Object_SetExecEnv: ObjCount: 1, CmdPending 0

Aug 10 15:32:46.796: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_RestoreDataBackup: Restore DataArea from Script

Aug 10 15:32:46.796: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_RestoreDataBackup: Restore TokenTable from Script

Aug 10 15:32:46.796: //-1//AFW_:/AFW_Event_New: Event ID: ev_session_indication

Aug 10 15:32:46.796: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_Initiate: Execenv = 0x67B8F67C

Aug 10 15:32:46.796: //-1//AFW_:EE67B8F67C000:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED

Aug 10 15:32:46.796: //-1//AFW_:EE67B8F67C000:/AFW_Process_GetAppQEvent: Received

Aug 10 15:32:46.800: //-1//AFW_:/AFW_Process_GetAppQEvent: Event[APP_EV_SESSION_START_IND(198)] {

Aug 10 15:32:46.800: //-1//AFW_:/AFW_Process_GetAppQEvent: EXECENV[0x67B8F67C][test]

Aug 10 15:32:46.800: //-1//AFW_:/AFW_Process_GetAppQEvent:

Aug 10 15:32:46.800: //-1//AFW_:EE67B8F67C000:/AFW_M_Module_GetHandle: Module handle: TclModule_69F31770_0_517949668MOD[TclModule_69F31770_0_517949668] (

Aug 10 15:32:46.800: //-1//AFW_:/AFW_Process_GetAppQEvent: )

Aug 10 15:32:46.800: //-1//AFW_:/AFW_Process_GetAppQEvent: }

Aug 10 15:32:46.800: //-1//AFW_:EE67B8F67C000:/AFW_M_TclModule_EventPreProcess:

Aug 10 15:32:46.800: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: TclModule_69F31770_0_517949668 ---> TclModule_69F31770_0_517949668

Aug 10 15:32:46.800: //-1//AFW_:EE67B8F67C000:/AFW_M_TclModule_Action:

Aug 10 15:32:46.800: //-1//AFW_:EE67B8F67C000:/AFW_TclModule_DefaultEvHandling:

Aug 10 15:32:46.800: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION BEGIN: ------(I[1],ev_session_indication[198])---[sess]------

Aug 10 15:32:46.800: //-1//TCL :EE67B8F67C000:/tcl_LegObjCmd: leg setup 202 callinfo

Aug 10 15:32:46.800: //-1//CSPK:EE67B8F67C000:/tcl_LegSetupObjCmd: leg setup 202 callinfo

Aug 10 15:32:46.804: //-1//CSPK:EE67B8F67C000:/C_CallSetup_Start: ControlInfo = 0x69FE6480, callInfo = 0x69F9C774, destination[0]=202

Aug 10 15:32:46.804: //-1//CSPK:EE67B8F67C000:/C_CallSetup_Start: configured mode=rotary (1)

Aug 10 15:32:46.804: //-1//CSPK:EE67B8F67C000:/C_CallSetup_Start: configured reroutemode=rotary (1)

Aug 10 15:32:46.804: //-1//Call:/AFW_CallSetup_New:

Aug 10 15:32:46.804: //-1//AFW_:/AFW_FSM_New:

Aug 10 15:32:46.804: //-1//AFW_:LP:EE67B8F67C000:HN1EDF48F0:/AFW_M_Object_SetExecEnv: ObjCount: 2, CmdPending 0

Aug 10 15:32:46.804: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 1

Aug 10 15:32:46.804: //-1//AFW_:EE67B8F67C000:/AFW_Object_AddListener: adding Module TclModule as listener

Aug 10 15:32:46.804: //-1//AFW_:EE67B8F67C000:/AFW_M_Module_GetHandle: Module handle: CallSetup_69139C08_0_517949680

Aug 10 15:32:46.804: //-1//Call:EE67B8F67C000:/AFW_CallSetup_AddDest: 202 index 0

Aug 10 15:32:46.804: //-1//Call:EE67B8F67C000:/AFW_M_CallSetup_Initiate:

Aug 10 15:32:46.804: //-1//Call:EE67B8F67C000:/CS_UpdateMLPPInfo: ServiceDomain:[none (0)] DomainIdentifier:[000000] PrecedenceLevel:[-1 (PRECEDENCE_LEVEL_NONE)] NormalizedPrecedence:[0 (INTERNAL_PRECEDENCE_0)] Preempt Hunt Not Set

Aug 10 15:32:46.804: //-1//Call:EE67B8F67C000:/CallSetupInitiate:

Aug 10 15:32:46.804: //-1//Call:EE67B8F67C000:/CS_Placecall:

Aug 10 15:32:46.808: //-1//Call:EE67B8F67C000:/CS_UpdateMLPPInfo: ServiceDomain:[none (0)] DomainIdentifier:[000000] PrecedenceLevel:[-1 (PRECEDENCE_LEVEL_NONE)] NormalizedPrecedence:[0 (INTERNAL_PRECEDENCE_0)] Preempt Hunt Not Set

Aug 10 15:32:46.808: //-1//Dest:/AFW_Destination_New:

Aug 10 15:32:46.808: //-1//AFW_:/AFW_FSM_New:

Aug 10 15:32:46.808: //-1//AFW_:LP:EE67B8F67C000:HN1EDF48F4:/AFW_M_Object_SetExecEnv: ObjCount: 3, CmdPending 1

Aug 10 15:32:46.808: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 2

Aug 10 15:32:46.808: //-1//AFW_:EE67B8F67C000:/AFW_Object_AddListener: adding Module CallSetup as listener

Aug 10 15:32:46.808: //-1//AFW_:EE67B8F67C000:/AFW_M_Module_GetHandle: Module handle: Destination_69151204_0_517949684

Aug 10 15:32:46.808: //-1//Dest:EE67B8F67C000:/AFW_Destination_AddDest:

Aug 10 15:32:46.808: //-1//Dest:/AFW_Destination_AddDest: adding destination "202"

Aug 10 15:32:46.808: //-1//Dest:EE67B8F67C000:/AFW_M_Destination_Initiate:

Aug 10 15:32:46.808: //-1//Dest:EE67B8F67C000:/AFW_M_Destination_Initiate: Outgoing guid : 1F25020B.3E9B11E5.87B0C175.851B1C9E

Aug 10 15:32:46.808: Incoming_guid : 00000000.00000000.00000000.00000000

Aug 10 15:32:46.808: //-1//Dest:EE67B8F67C000:/AFW_M_Destination_Initiate: Outgoing gcid : 00000000.00000000.00000000.00000000

Aug 10 15:32:46.808: Incoming_gcid : 00000000.00000000.00000000.00000000

Aug 10 15:32:46.808: //-1//Dest:EE67B8F67C000:/DestUpdateMLPPInfo: ServiceDomain:[none (0)] DomainIdentifier:[000000] PrecedenceLevel:[-1 (PRECEDENCE_LEVEL_NONE)] NormalizedPrecedence:[-1 (PRECEDENCE_LEVEL_NONE)] Preempt Hunt Not Set

Aug 10 15:32:46.808: //-1//Dest:EE67B8F67C000:/DestSetupInitiate:

Aug 10 15:32:46.808: //-1//Dest:EE67B8F67C000:/DestAddRerouteSetupInfo:

Aug 10 15:32:46.808: //-1//Dest:EE67B8F67C000:/DestAddTransferSetupInfo:

Aug 10 15:32:46.812: //-1//AFW_:/AFW_Util_CopyCallDataToCallInfo: copied 202

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestMatchDialPeer:

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestMatchDialPeer: src carrier id:, tgt carrier id:

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestQueuePeers: Matched peers:

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestPeerItemUpdatePreemptInfo:

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestPeerItemResetLPCORInfo:

Aug 10 15:32:46.812: //-1//Dest:/DestQueuePeers: 200

Aug 10 15:32:46.812: //-1//Dest:/DestQueuePeers: , Total(1)

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestDialPeerRotary:

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestOutboundCallUsingPeer: dest(202), numexpDest(202), numDestDigits(2)

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestOutboundCallUsingPeer: prefix(.55), peer tag(200)

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestUpdatePreemptSetupInfo:

Aug 10 15:32:46.812: //-1//AFW_:/AFW_Util_RemovePreemptInfoFromContainer: Failed to remove mlppSetupInfo from TD container

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestDialPeerFilter:

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestDialPeerFilter: Checking peer [200]

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestPeerFilterRouteCode: Route Code not available

Aug 10 15:32:46.812: //-1//Dest:/DestOutboundCallUsingPeer: Outgoing Tag(200) calling[] called[202]

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestCheckTeleUnassBusy:

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestHandleLPCOR:

Aug 10 15:32:46.812: //-1//Dest:EE67B8F67C000:/DestSetup:

Aug 10 15:32:46.812: //-1//AFW_:/AFW_Leg_GetTypeDetail: ***ERROR*** pLeg is NULL

Aug 10 15:32:46.812: //-1//AFW_:/AFW_Util_SaveRawMsg:

Aug 10 15:32:46.812: //-1//AFW_:/AFW_Leg_New:

Aug 10 15:32:46.816: //1075/1F25020B87B0/AFW_:/AFW_Leg_NewSetupRequest: ccCallSetupRequest done

Aug 10 15:32:46.816: //1075/1F25020B87B0/AFW_:/AFW_M_Leg_SetExecEnv:

Aug 10 15:32:46.816: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_IncrPendingCmd: PendingCmdCount: 3

Aug 10 15:32:46.816: //-1/1F25020B87B0/AFW_:LP:EE67B8F67C000:LG1075:/AFW_M_Object_SetExecEnv: ObjCount: 4, CmdPending 3

Aug 10 15:32:46.816: //1075/1F25020B87B0/AFW_:/AFW_Object_AddListener: adding Module Destination as listener

Aug 10 15:32:46.816: //1075/1F25020B87B0/AFW_:/AFW_M_Leg_GetHandle: Leg handle: LEG_1075

Aug 10 15:32:46.816: //1075/1F25020B87B0/AFW_:/AFW_Leg_UpdateStats: Updating stats for ID 12C type 3

Aug 10 15:32:46.816: //-1//Dest:EE67B8F67C000:/DestSetup: Destination setup success

Aug 10 15:32:46.816: //-1//Dest:EE67B8F67C000:/AFW_M_Destination_Initiate: attempting call to destination 202

Aug 10 15:32:46.816: //-1//Call:EE67B8F67C000:/CS_Placecall: Call placed to 202 index 0

Aug 10 15:32:46.816: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION END: -------------(I[1])---------------

Aug 10 15:32:46.816: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: TclModule_69F31770_0_517949668 ---> TclModule_69F31770_0_517949668

Aug 10 15:32:46.816: //-1//AFW_:EE67B8F67C000:/AFW_M_Event_Free:

Aug 10 15:32:46.816: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_CloseIfDone: Cmd Count: 3

Aug 10 15:32:46.816: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 15:32:46.816: //-1//AFW_:/AFW_M_Event_Free:

Aug 10 15:32:46.820: //-1//AFW_:/AFW_M_Event_Free: Null or invalid event context: for event APP_EV_NULL

Aug 10 15:32:46.824: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 15:32:46.828: //1075/1F25020B87B0/AFW_:/AFW_Process_GetCcqEvent: Received

Aug 10 15:32:46.828: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_PROCEEDING(31)] {

Aug 10 15:32:46.828: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x67B8F67C][test]

Aug 10 15:32:46.828: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[1075][LEG_OUTINIT(7)][Cause(0)]

Aug 10 15:32:46.828: //-1//AFW_:/AFW_Process_GetCcqEvent: }

Aug 10 15:32:46.828: //1075/1F25020B87B0/SSIN:/AFW_SS_MapEvent:

Aug 10 15:32:46.828: //-1//SSIN:/AFW_SS_SIP_MapEvent:

Aug 10 15:32:46.828: //1075/1F25020B87B0/AFW_:/AFW_M_Leg_EventPreProcess: LEG[1075 ][LEG_OUTINIT(7)][Cause(0)]

Aug 10 15:32:46.828: //1075/1F25020B87B0/AFW_:/AFW_Object_WalkListeners:

Aug 10 15:32:46.828: //1075/1F25020B87B0/AFW_:/AFW_M_Object_ShowListeners: START

Aug 10 15:32:46.828: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_69151204_0_517949684] (

Aug 10 15:32:46.828: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[1075][LEG_OUTINIT(7)][Cause(0)]

Aug 10 15:32:46.828: //-1//AFW_:/AFW_M_Object_ShowListeners: )

Aug 10 15:32:46.828: //1075/1F25020B87B0/AFW_:/AFW_M_Object_ShowListeners: END

Aug 10 15:32:46.828: //1075/1F25020B87B0/AFW_:/AFW_Object_WalkListeners: Entering Module : Destination

Aug 10 15:32:46.828: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: TclModule_69F31770_0_517949668 ---> Destination_69151204_0_517949684

Aug 10 15:32:46.828: //-1//Dest:EE67B8F67C000:/AFW_M_Destination_Action:

Aug 10 15:32:46.828: //-1//Dest:EE67B8F67C000:/AFW_Destination_Action:

Aug 10 15:32:46.828: //-1//Dest:EE67B8F67C000:/OB_FSM_Drive:

Aug 10 15:32:46.828: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: Destination_69151204_0_517949684 ---> Destination_69151204_0_517949684

Aug 10 15:32:46.828: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION BEGIN: ------(OB_STATE_SETTING[3],ev_proceeding[31])---[C_Action]------

Aug 10 15:32:46.828: //-1//Dest:EE67B8F67C000:/OB_Setting_Proceeding:

Aug 10 15:32:46.828: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION END: -------------(OB_STATE_SETTING[3])---------------

Aug 10 15:32:46.828: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: Destination_69151204_0_517949684 ---> Destination_69151204_0_517949684

Aug 10 15:32:46.828: //-1//Dest:EE67B8F67C000:/IW_FSM_Drive:

Aug 10 15:32:46.828: //-1//Dest:EE67B8F67C000:/IW_FSM_Drive: No interworking leg, no need to interwork event

Aug 10 15:32:46.828: //-1//Dest:EE67B8F67C000:/DestIsEventNotified:

Aug 10 15:32:46.828: //-1//Dest:EE67B8F67C000:/DestComplete: peer #:200 IW State IW_STATE_INIT, OB State OB_STATE_SETTING

Aug 10 15:32:46.828: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: Destination_69151204_0_517949684 ---> TclModule_69F31770_0_517949668

Aug 10 15:32:46.832: //1075/1F25020B87B0/AFW_:/AFW_M_Event_Free:

Aug 10 15:32:46.832: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_CloseIfDone: Cmd Count: 3

Aug 10 15:32:46.832: //1075/1F25020B87B0/SIP/Msg/ccsipDisplayMsg:

Sent:

INVITE sip:202@10.160.3.55:5060 SIP/2.0

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28E1BFA

From: <sip:10.160.3.56>;tag=1EDF4904-252

To: <sip:202@10.160.3.55>

Date: Mon, 10 Aug 2015 13:32:46 GMT

Call-ID: 1F280ED2-3E9B11E5-87B3C175-851B1C9E@10.160.3.56

Supported: 100rel,timer,resource-priority,replaces,sdp-anat

Min-SE: 1800

Cisco-Guid: 0522519051-1050350053-2276508021-2233146526

User-Agent: Cisco-SIPGateway/IOS-12.x

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

CSeq: 101 INVITE

Max-Forwards: 70

Timestamp: 1439213566

Contact: <sip:10.160.3.56:5060>

Expires: 180

Allow-Events: telephone-event

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 267

v=0

o=CiscoSystemsSIP-GW-UserAgent 278 8518 IN IP4 10.160.3.56

s=SIP Call

c=IN IP4 10.160.3.56

t=0 0

m=audio 16384 RTP/AVP 0 101 19

c=IN IP4 10.160.3.56

a=rtpmap:0 PCMU/8000

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=rtpmap:19 CN/8000

a=ptime:20

Aug 10 15:32:46.844: //1075/1F25020B87B0/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28E1BFA

From: <sip:10.160.3.56>;tag=1EDF4904-252

To: <sip:202@10.160.3.55>

Date: Mon, 10 Aug 2015 13:32:46 GMT

Call-ID: 1F280ED2-3E9B11E5-87B3C175-851B1C9E@10.160.3.56

Timestamp: 1439213566

CSeq: 101 INVITE

Allow-Events: telephone-event

Server: Cisco-SIPGateway/IOS-12.x

Content-Length: 0

Aug 10 15:32:46.844: //1075/1F25020B87B0/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 302 Moved Temporarily

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28E1BFA

From: <sip:10.160.3.56>;tag=1EDF4904-252

To: <sip:202@10.160.3.55>;tag=1EAE6A9C-E78

Date: Mon, 10 Aug 2015 13:32:46 GMT

Call-ID: 1F280ED2-3E9B11E5-87B3C175-851B1C9E@10.160.3.56

Timestamp: 1439213566

CSeq: 101 INVITE

Allow-Events: telephone-event

Server: Cisco-SIPGateway/IOS-12.x

Diversion: <sip:202@10.160.3.55>;reason=unconditional;counter=1

Contact: <sip:203@10.160.3.55>

Content-Length: 0

Aug 10 15:32:46.852: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 15:32:46.852: //1075/1F25020B87B0/AFW_:/AFW_Process_GetCcqEvent: Received

Aug 10 15:32:46.852: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_FEATURE(38)] {

Aug 10 15:32:46.852: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x67B8F67C][test]

Aug 10 15:32:46.852: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[1075][LEG_OUTPROCEED(8)][Cause(0)]

Aug 10 15:32:46.852: //-1//AFW_:/AFW_Process_GetCcqEvent: }

Aug 10 15:32:46.852: //-1//SSIN:/AFW_SS_MapEvent: No mapping required

Aug 10 15:32:46.852: //1075/1F25020B87B0/AFW_:/AFW_M_Leg_EventPreProcess: LEG[1075 ][LEG_OUTPROCEED(8)][Cause(0)]

Aug 10 15:32:46.852: //1075/1F25020B87B0/AFW_:/AFW_Object_WalkListeners:

Aug 10 15:32:46.852: //1075/1F25020B87B0/AFW_:/AFW_M_Object_ShowListeners: START

Aug 10 15:32:46.852: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_69151204_0_517949684] (

Aug 10 15:32:46.852: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[1075][LEG_OUTPROCEED(8)][Cause(0)]

Aug 10 15:32:46.852: //-1//AFW_:/AFW_M_Object_ShowListeners: )

Aug 10 15:32:46.852: //1075/1F25020B87B0/AFW_:/AFW_M_Object_ShowListeners: END

Aug 10 15:32:46.852: //1075/1F25020B87B0/AFW_:/AFW_Object_WalkListeners: Entering Module : Destination

Aug 10 15:32:46.852: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: NULL ---> Destination_69151204_0_517949684

Aug 10 15:32:46.852: //-1//Dest:EE67B8F67C000:/AFW_M_Destination_Action:

Aug 10 15:32:46.852: //-1//Dest:EE67B8F67C000:/AFW_Destination_Action:

Aug 10 15:32:46.852: //-1//Dest:EE67B8F67C000:/OB_FSM_Drive:

Aug 10 15:32:46.856: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: Destination_69151204_0_517949684 ---> Destination_69151204_0_517949684

Aug 10 15:32:46.856: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION BEGIN: ------(OB_STATE_SETTING[3],ev_feature[38])---[C_Action]------

Aug 10 15:32:46.856: //-1//Dest:EE67B8F67C000:/OB_Ignore: IGNORING EVENT

Aug 10 15:32:46.856: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION END: -------------(OB_STATE_SETTING[3])---------------

Aug 10 15:32:46.856: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: Destination_69151204_0_517949684 ---> Destination_69151204_0_517949684

Aug 10 15:32:46.856: //-1//Dest:EE67B8F67C000:/IW_FSM_Drive:

Aug 10 15:32:46.856: //-1//Dest:EE67B8F67C000:/IW_FSM_Drive: No interworking leg, no need to interwork event

Aug 10 15:32:46.856: //-1//Dest:EE67B8F67C000:/DestIsEventNotified:

Aug 10 15:32:46.856: //-1//Dest:EE67B8F67C000:/DestComplete: peer #:200 IW State IW_STATE_INIT, OB State OB_STATE_SETTING

Aug 10 15:32:46.856: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: Destination_69151204_0_517949684 ---> NULL

Aug 10 15:32:46.856: //1075/1F25020B87B0/AFW_:/AFW_M_Event_Free:

Aug 10 15:32:46.856: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_CloseIfDone: Cmd Count: 3

Aug 10 15:32:46.856: //1075/1F25020B87B0/SIP/Msg/ccsipDisplayMsg:

Sent:

ACK sip:202@10.160.3.55:5060 SIP/2.0

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28E1BFA

From: <sip:10.160.3.56>;tag=1EDF4904-252

To: <sip:202@10.160.3.55>;tag=1EAE6A9C-E78

Date: Mon, 10 Aug 2015 13:32:46 GMT

Call-ID: 1F280ED2-3E9B11E5-87B3C175-851B1C9E@10.160.3.56

Max-Forwards: 70

CSeq: 101 ACK

Allow-Events: telephone-event

Content-Length: 0

Aug 10 15:32:46.860: //1075/1F25020B87B0/SIP/Msg/ccsipDisplayMsg:

Sent:

INVITE sip:203@10.160.3.55:5060 SIP/2.0

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28F1199

From: <sip:10.160.3.56>;tag=1EDF491C-1CC5

To: <sip:202@10.160.3.55>

Date: Mon, 10 Aug 2015 13:32:46 GMT

Call-ID: 1F280ED2-3E9B11E5-87B3C175-851B1C9E@10.160.3.56

Supported: 100rel,timer,resource-priority,replaces,sdp-anat

Min-SE: 1800

Cisco-Guid: 0522519051-1050350053-2276508021-2233146526

User-Agent: Cisco-SIPGateway/IOS-12.x

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

CSeq: 102 INVITE

Max-Forwards: 70

Timestamp: 1439213566

Contact: <sip:10.160.3.56:5060>

Diversion: <sip:202@10.160.3.55>;reason=unconditional;counter=1

Expires: 180

Allow-Events: telephone-event

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 267

v=0

o=CiscoSystemsSIP-GW-UserAgent 278 8518 IN IP4 10.160.3.56

s=SIP Call

c=IN IP4 10.160.3.56

t=0 0

m=audio 16384 RTP/AVP 0 101 19

c=IN IP4 10.160.3.56

a=rtpmap:0 PCMU/8000

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=rtpmap:19 CN/8000

a=ptime:20

Aug 10 15:32:46.872: //1075/1F25020B87B0/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28F1199

From: <sip:10.160.3.56>;tag=1EDF491C-1CC5

To: <sip:202@10.160.3.55>

Date: Mon, 10 Aug 2015 13:32:46 GMT

Call-ID: 1F280ED2-3E9B11E5-87B3C175-851B1C9E@10.160.3.56

Timestamp: 1439213566

CSeq: 102 INVITE

Allow-Events: telephone-event

Server: Cisco-SIPGateway/IOS-12.x

Content-Length: 0

Aug 10 15:32:46.876: //1075/1F25020B87B0/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 180 Ringing

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28F1199

From: <sip:10.160.3.56>;tag=1EDF491C-1CC5

To: <sip:202@10.160.3.55>;tag=1EAE6ABC-1275

Date: Mon, 10 Aug 2015 13:32:46 GMT

Call-ID: 1F280ED2-3E9B11E5-87B3C175-851B1C9E@10.160.3.56

Timestamp: 1439213566

CSeq: 102 INVITE

Require: 100rel

RSeq: 1785

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

Allow-Events: telephone-event

Remote-Party-ID: "Ext. twozerothree" <sip:203@10.160.3.55>;party=called;screen=no;privacy=off

Contact: <sip:203@10.160.3.55:5060>

Server: Cisco-SIPGateway/IOS-12.x

Content-Length: 0

Aug 10 15:32:46.880: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 15:32:46.880: //1075/1F25020B87B0/AFW_:/AFW_Process_GetCcqEvent: Received

Aug 10 15:32:46.880: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_ALERT(16)] {

Aug 10 15:32:46.880: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x67B8F67C][test]

Aug 10 15:32:46.880: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[1075][LEG_OUTPROCEED(8)][Cause(0)]

Aug 10 15:32:46.880: //-1//AFW_:/AFW_Process_GetCcqEvent: }

Aug 10 15:32:46.880: //1075/1F25020B87B0/SSIN:/AFW_SS_MapEvent:

Aug 10 15:32:46.880: //-1//SSIN:/AFW_SS_SIP_MapEvent:

Aug 10 15:32:46.880: //1075/1F25020B87B0/AFW_:/AFW_Object_WalkListeners:

Aug 10 15:32:46.880: //1075/1F25020B87B0/AFW_:/AFW_M_Object_ShowListeners: START

Aug 10 15:32:46.880: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_69151204_0_517949684] (

Aug 10 15:32:46.880: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[1075][LEG_OUTPROCEED(8)][Cause(0)]

Aug 10 15:32:46.880: //-1//AFW_:/AFW_M_Object_ShowListeners: )

Aug 10 15:32:46.880: //1075/1F25020B87B0/AFW_:/AFW_M_Object_ShowListeners: END

Aug 10 15:32:46.880: //1075/1F25020B87B0/AFW_:/AFW_Object_WalkListeners: Entering Module : Destination

Aug 10 15:32:46.880: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: NULL ---> Destination_69151204_0_517949684

Aug 10 15:32:46.884: //-1//Dest:EE67B8F67C000:/AFW_M_Destination_Action:

Aug 10 15:32:46.884: //-1//Dest:EE67B8F67C000:/AFW_Destination_Action:

Aug 10 15:32:46.884: //-1//Dest:EE67B8F67C000:/OB_FSM_Drive:

Aug 10 15:32:46.884: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: Destination_69151204_0_517949684 ---> Destination_69151204_0_517949684

Aug 10 15:32:46.884: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION BEGIN: ------(OB_STATE_SETTING[3],ev_alert[16])---[C_Action]------

Aug 10 15:32:46.884: //-1//Dest:EE67B8F67C000:/OB_Setting_Alert:

Aug 10 15:32:46.884: //-1//Dest:/OB_Setting_Alert: aData bitmask 0x80000001

Aug 10 15:32:46.884: //-1//Dest:/OB_Setting_Alert: aData.display_info=Ext. twozerothree

Aug 10 15:32:46.884: //1075/1F25020B87B0/AFW_:/AFW_Util_FillDispNotifyData: Current: notifyData.connected_num.num_string =203,notifyData.display_info = Ext. twozerothree,notifyData.connected_num.oct3a = 0

Aug 10 15:32:46.884: //1075/1F25020B87B0/AFW_:/AFW_Util_FillDispNotifyData: Filled : notifyData.connected_num.num_string =203,notifyData.display_info = Ext. twozerothree,notifyData.connected_num.oct3a = 0

Aug 10 15:32:46.884: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION END: -------------(OB_STATE_SETTING[3])---------------

Aug 10 15:32:46.884: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: Destination_69151204_0_517949684 ---> Destination_69151204_0_517949684

Aug 10 15:32:46.884: //-1//Dest:EE67B8F67C000:/IW_FSM_Drive:

Aug 10 15:32:46.884: //-1//Dest:EE67B8F67C000:/IW_FSM_Drive: No interworking leg, no need to interwork event

Aug 10 15:32:46.884: //-1//Dest:EE67B8F67C000:/DestIsEventNotified:

Aug 10 15:32:46.884: //-1//Dest:EE67B8F67C000:/DestComplete: peer #:200 IW State IW_STATE_INIT, OB State OB_STATE_SETTING

Aug 10 15:32:46.884: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: Destination_69151204_0_517949684 ---> NULL

Aug 10 15:32:46.884: //1075/1F25020B87B0/AFW_:/AFW_M_Event_Free:

Aug 10 15:32:46.884: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_CloseIfDone: Cmd Count: 3

Aug 10 15:32:46.940: //1075/1F25020B87B0/SIP/Msg/ccsipDisplayMsg:

Sent:

PRACK sip:203@10.160.3.55:5060 SIP/2.0

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK290FE

From: <sip:10.160.3.56>;tag=1EDF491C-1CC5

To: <sip:202@10.160.3.55>;tag=1EAE6ABC-1275

Date: Mon, 10 Aug 2015 13:32:46 GMT

Call-ID: 1F280ED2-3E9B11E5-87B3C175-851B1C9E@10.160.3.56

CSeq: 103 PRACK

RAck: 1785 102 INVITE

Allow-Events: telephone-event

Max-Forwards: 70

Content-Length: 0

Aug 10 15:32:46.944: //1075/1F25020B87B0/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 200 OK

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK290FE

From: <sip:10.160.3.56>;tag=1EDF491C-1CC5

To: <sip:202@10.160.3.55>;tag=1EAE6ABC-1275

Date: Mon, 10 Aug 2015 13:32:46 GMT

Call-ID: 1F280ED2-3E9B11E5-87B3C175-851B1C9E@10.160.3.56

Server: Cisco-SIPGateway/IOS-12.x

CSeq: 103 PRACK

Content-Length: 0

Aug 10 15:32:50.355: //1075/1F25020B87B0/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 200 OK

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK28F1199

From: <sip:10.160.3.56>;tag=1EDF491C-1CC5

To: <sip:202@10.160.3.55>;tag=1EAE6ABC-1275

Date: Mon, 10 Aug 2015 13:32:46 GMT

Call-ID: 1F280ED2-3E9B11E5-87B3C175-851B1C9E@10.160.3.56

Timestamp: 1439213566

CSeq: 102 INVITE

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

Allow-Events: telephone-event

Remote-Party-ID: "Ext. twozerothree" <sip:203@10.160.3.55>;party=called;screen=no;privacy=off

Contact: <sip:203@10.160.3.55:5060>

Supported: replaces

Supported: sdp-anat

Server: Cisco-SIPGateway/IOS-12.x

Supported: timer

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 268

v=0

o=CiscoSystemsSIP-GW-UserAgent 5624 8833 IN IP4 10.160.3.55

s=SIP Call

c=IN IP4 10.160.3.55

t=0 0

m=audio 17530 RTP/AVP 0 19 101

c=IN IP4 10.160.3.55

a=rtpmap:0 PCMU/8000

a=rtpmap:19 CN/8000

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=ptime:20

Aug 10 15:32:50.363: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 15:32:50.363: //1075/1F25020B87B0/AFW_:/AFW_Process_GetCcqEvent: Received

Aug 10 15:32:50.363: //-1//AFW_:/AFW_Process_GetCcqEvent: Event[CC_EV_CALL_CONNECTED(17)] {

Aug 10 15:32:50.363: //-1//AFW_:/AFW_Process_GetCcqEvent: EXECENV[0x67B8F67C][test]

Aug 10 15:32:50.363: //-1//AFW_:/AFW_Process_GetCcqEvent: LEG[1075][LEG_OUTRINGING(9)][Cause(0)]

Aug 10 15:32:50.363: //-1//AFW_:/AFW_Process_GetCcqEvent: }

Aug 10 15:32:50.363: //1075/1F25020B87B0/SSIN:/AFW_SS_MapEvent:

Aug 10 15:32:50.363: //-1//SSIN:/AFW_SS_SIP_MapEvent:

Aug 10 15:32:50.363: //1075/1F25020B87B0/AFW_:/AFW_Leg_UpdateStats: Updating stats for ID 12C type 1

Aug 10 15:32:50.363: //1075/1F25020B87B0/AFW_:/AFW_Object_WalkListeners:

Aug 10 15:32:50.363: //1075/1F25020B87B0/AFW_:/AFW_M_Object_ShowListeners: START

Aug 10 15:32:50.363: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_69151204_0_517949684] (

Aug 10 15:32:50.363: //-1//AFW_:/AFW_M_Object_ShowListeners: LEG[1075][LEG_OUTCONNECTED(10)][Cause(0)]

Aug 10 15:32:50.363: //-1//AFW_:/AFW_M_Object_ShowListeners: )

Aug 10 15:32:50.363: //1075/1F25020B87B0/AFW_:/AFW_M_Object_ShowListeners: END

Aug 10 15:32:50.363: //1075/1F25020B87B0/AFW_:/AFW_Object_WalkListeners: Entering Module : Destination

Aug 10 15:32:50.367: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: NULL ---> Destination_69151204_0_517949684

Aug 10 15:32:50.367: //-1//Dest:EE67B8F67C000:/AFW_M_Destination_Action:

Aug 10 15:32:50.367: //-1//Dest:EE67B8F67C000:/AFW_Destination_Action:

Aug 10 15:32:50.367: //-1//Dest:EE67B8F67C000:/OB_FSM_Drive:

Aug 10 15:32:50.367: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: Destination_69151204_0_517949684 ---> Destination_69151204_0_517949684

Aug 10 15:32:50.367: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION BEGIN: ------(OB_STATE_SETTING[3],ev_connected[17])---[C_Action]------

Aug 10 15:32:50.367: //-1//Dest:EE67B8F67C000:/OB_Setting_Connect:

Aug 10 15:32:50.367: //-1//Dest:/OB_Setting_Connect: cData.display_info=Ext. twozerothree

Aug 10 15:32:50.367: //1075/1F25020B87B0/AFW_:/AFW_Util_FillDispNotifyData: Current: notifyData.connected_num.num_string =203,notifyData.display_info = Ext. twozerothree,notifyData.connected_num.oct3a = 0

Aug 10 15:32:50.367: //1075/1F25020B87B0/AFW_:/AFW_Util_FillDispNotifyData: Filled : notifyData.connected_num.num_string =203,notifyData.display_info = Ext. twozerothree,notifyData.connected_num.oct3a = 0

Aug 10 15:32:50.367: //-1//Dest:EE67B8F67C000:/DestNotifySharedLnState: callid: 1075, peer: 200

Aug 10 15:32:50.367: //-1//Dest:EE67B8F67C000:/DestNotifySharedLnState: Shared-Line NOT enabled!

Aug 10 15:32:50.367: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION END: -------------(OB_STATE_DONE[8])---------------

Aug 10 15:32:50.367: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: Destination_69151204_0_517949684 ---> Destination_69151204_0_517949684

Aug 10 15:32:50.367: //-1//Dest:EE67B8F67C000:/IW_FSM_Drive:

Aug 10 15:32:50.367: //-1//Dest:EE67B8F67C000:/IW_FSM_Drive: No interworking leg, no need to interwork event

Aug 10 15:32:50.367: //-1//Dest:EE67B8F67C000:/DestIsEventNotified:

Aug 10 15:32:50.367: //-1//Dest:EE67B8F67C000:/DestComplete: peer #:200 IW State IW_STATE_INIT, OB State OB_STATE_DONE

Aug 10 15:32:50.367: //-1//AFW_:/AFW_Event_New: Event ID: ev_destination_done

Aug 10 15:32:50.367: //-1//AFW_:EE67B8F67C000:/AFW_Module_ReturnArgEv:

Aug 10 15:32:50.367: //-1//AFW_:EE67B8F67C000:/AFW_Module_ReturnArgEv: Return List (remove=TRUE){LEG[1075 ][LEG_OUTCONNECTED(10)][Cause(0)]}

Aug 10 15:32:50.371: //1075/1F25020B87B0/AFW_:/AFW_Object_RemoveListener:

Aug 10 15:32:50.371: //-1//AFW_:EE67B8F67C000:/AFW_Module_UnListen: NumObjects: 0

Aug 10 15:32:50.371: //-1//Dest:EE67B8F67C000:/DestReturn: Destination Returning(ds_000 Status DEST_ACTIVE)

Aug 10 15:32:50.371: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: Destination_69151204_0_517949684 ---> NULL

Aug 10 15:32:50.371: //1075/1F25020B87B0/AFW_:/AFW_M_Event_Free:

Aug 10 15:32:50.371: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_CloseIfDone: Cmd Count: 3

Aug 10 15:32:50.371: //-1//AFW_:EE67B8F67C000:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED

Aug 10 15:32:50.371: //-1//AFW_:EE67B8F67C000:/AFW_Process_GetPriorityQEvent: Received

Aug 10 15:32:50.371: //-1//AFW_:/AFW_Process_GetPriorityQEvent: Event[APP_EV_DESTINATION_DONE(221)] {

Aug 10 15:32:50.371: //-1//AFW_:/AFW_Process_GetPriorityQEvent: EXECENV[0x67B8F67C][test]

Aug 10 15:32:50.371: //-1//AFW_:/AFW_Process_GetPriorityQEvent: MOD[Destination_69151204_0_517949684] (

Aug 10 15:32:50.371: //-1//AFW_:/AFW_Process_GetPriorityQEvent: )

Aug 10 15:32:50.371: //-1//AFW_:/AFW_Process_GetPriorityQEvent: }

Aug 10 15:32:50.371: //-1//Dest:EE67B8F67C000:/AFW_M_Destination_EventPreProcess:

Aug 10 15:32:50.371: //1075/1F25020B87B0/Dest:/DestUpdateSuccessStats:

Aug 10 15:32:50.371: //-1//AFW_:EE67B8F67C000:/AFW_Object_WalkListeners:

Aug 10 15:32:50.371: //-1//AFW_:EE67B8F67C000:/AFW_M_Object_ShowListeners: START

Aug 10 15:32:50.371: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[CallSetup_69139C08_0_517949680] (

Aug 10 15:32:50.371: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[Destination_69151204_0_517949684] (

Aug 10 15:32:50.371: //-1//AFW_:/AFW_M_Object_ShowListeners: )

Aug 10 15:32:50.371: //-1//AFW_:EE67B8F67C000:/AFW_M_Object_ShowListeners: END

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_Object_WalkListeners: Entering Module : CallSetup

Aug 10 15:32:50.375: //1075/1F25020B87B0/AFW_:/AFW_Object_AddListener: adding Module CallSetup as listener

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_Object_RemoveListener:

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_Module_UnListen: NumObjects: 1

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: NULL ---> CallSetup_69139C08_0_517949680

Aug 10 15:32:50.375: //-1//Call:EE67B8F67C000:/AFW_M_CallSetup_Action:

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION BEGIN: ------(S_PLACECALL[2],ev_destination_done[221])---[C_Action]------

Aug 10 15:32:50.375: //-1//Call:EE67B8F67C000:/CS_Placecall_DestDone:

Aug 10 15:32:50.375: //-1//Call:EE67B8F67C000:/CS_DestDone_CapturePreemptStatus: PreemptErrorCode 0; Play prompt none

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION END: -------------(S_DONE[13])---------------

Aug 10 15:32:50.375: //-1//AFW_:/AFW_Event_New: Event ID: ev_setup_done

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_Module_ReturnArgEv:

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_Module_ReturnArgEv: Return List (remove=TRUE){LEG[1075 ][LEG_OUTCONNECTED(10)][Cause(0)]}

Aug 10 15:32:50.375: //1075/1F25020B87B0/AFW_:/AFW_Object_RemoveListener:

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_Module_UnListen: NumObjects: 0

Aug 10 15:32:50.375: //-1//Call:EE67B8F67C000:/CS_Complete: CallSetup Returning(ls_000 Status CS_ACTIVE)

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: CallSetup_69139C08_0_517949680 ---> NULL

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_Object_WalkListeners:

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_M_Object_ShowListeners: START

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_M_Object_ShowListeners: END

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_M_Event_Free:

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_M_Event_Free: MODULEDONEEVENT for a Module: Destination_69151204_0_517949684

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_Object_RemoveAllListener:

Aug 10 15:32:50.375: //-1//AFW_:/AFW_M_Object_UnSetExecEnv: ObjCount: 3, CmdPending 3

Aug 10 15:32:50.375: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_DecrNPendingCmd: PendingCmdCount: 2

Aug 10 15:32:50.375: //-1//AFW_:HN1EDF48F4:/AFW_M_Event_Free: ExecEnv objCount: 3

Aug 10 15:32:50.375: //-1//Dest:HN1EDF48F4:/AFW_M_Destination_Free:

Aug 10 15:32:50.379: //-1//Dest:HN1EDF48F4:/DestEmptyPreemptHoldQ:

Aug 10 15:32:50.379: //-1//AFW_:/AFW_M_FSM_Free:

Aug 10 15:32:50.379: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_CloseIfDone: Cmd Count: 2

Aug 10 15:32:50.379: //-1//AFW_:EE67B8F67C000:/AFW_Event_IsOk: AppEventOk Success - timestamp MATCHED

Aug 10 15:32:50.379: //-1//AFW_:EE67B8F67C000:/AFW_Process_GetPriorityQEvent: Received

Aug 10 15:32:50.379: //-1//AFW_:/AFW_Process_GetPriorityQEvent: Event[APP_EV_CALLSETUP_DONE(219)] {

Aug 10 15:32:50.379: //-1//AFW_:/AFW_Process_GetPriorityQEvent: EXECENV[0x67B8F67C][test]

Aug 10 15:32:50.379: //-1//AFW_:/AFW_Process_GetPriorityQEvent: MOD[CallSetup_69139C08_0_517949680] (

Aug 10 15:32:50.379: //-1//AFW_:/AFW_Process_GetPriorityQEvent: )

Aug 10 15:32:50.379: //-1//AFW_:/AFW_Process_GetPriorityQEvent: }

Aug 10 15:32:50.379: //-1//Call:EE67B8F67C000:/AFW_M_CallSetup_EventPreProcess:

Aug 10 15:32:50.379: //-1//AFW_:EE67B8F67C000:/AFW_Object_WalkListeners:

Aug 10 15:32:50.379: //-1//AFW_:EE67B8F67C000:/AFW_M_Object_ShowListeners: START

Aug 10 15:32:50.379: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[TclModule_69F31770_0_517949668] (

Aug 10 15:32:50.379: //-1//AFW_:/AFW_M_Object_ShowListeners: MOD[CallSetup_69139C08_0_517949680] (

Aug 10 15:32:50.379: //-1//AFW_:/AFW_M_Object_ShowListeners: )

Aug 10 15:32:50.379: //-1//AFW_:EE67B8F67C000:/AFW_M_Object_ShowListeners: END

Aug 10 15:32:50.379: //-1//AFW_:EE67B8F67C000:/AFW_Object_WalkListeners: Entering Module : TclModule

Aug 10 15:32:50.379: //1075/1F25020B87B0/AFW_:/AFW_Object_AddListener: adding Module TclModule as listener

Aug 10 15:32:50.379: //-1//AFW_:EE67B8F67C000:/AFW_Object_RemoveListener:

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_Module_UnListen: NumObjects: 1

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: NULL ---> TclModule_69F31770_0_517949668

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_M_TclModule_Action:

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_TclModule_DefaultEvHandling:

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_TclModule_UpdateSessionMask: Update intwrk-mask for leg [1075]'s session

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION BEGIN: ------(I[1],ev_setup_done[219])---[setupDone]------

Aug 10 15:32:50.383: //-1//TCL :EE67B8F67C000:/tcl_InfotagObjCmd: infotag get evt_status

Aug 10 15:32:50.383: //-1//TCL :EE67B8F67C000:/tcl_InfotagGetObjCmd: infotag get evt_status

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/vtr_ev_status: argc 2 argindex 2

Aug 10 15:32:50.383: //-1//TCL :EE67B8F67C000:/tcl_PutsObjCmd: ls_000

Aug 10 15:32:50.383:

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION END: -------------(I[1])---------------

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_SetModuleScope: TclModule_69F31770_0_517949668 ---> NULL

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_Object_WalkListeners:

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_M_Object_ShowListeners: START

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_M_Object_ShowListeners: END

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_M_Event_Free:

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_M_Event_Free: MODULEDONEEVENT for a Module: CallSetup_69139C08_0_517949680

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_Object_RemoveAllListener:

Aug 10 15:32:50.383: //-1//AFW_:/AFW_M_Object_UnSetExecEnv: ObjCount: 2, CmdPending 2

Aug 10 15:32:50.383: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_DecrNPendingCmd: PendingCmdCount: 1

Aug 10 15:32:50.383: //-1//AFW_:HN1EDF48F0:/AFW_M_Event_Free: ExecEnv objCount: 2

Aug 10 15:32:50.383: //-1//Call:HN1EDF48F0:/AFW_M_CallSetup_Free:

Aug 10 15:32:50.383: //-1//AFW_:/AFW_M_FSM_Free:

Aug 10 15:32:50.387: //-1//AFW_:EE67B8F67C000:/AFW_ExecEnv_CloseIfDone: Cmd Count: 1

Aug 10 15:32:50.387: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 15:32:50.387: //-1//AFW_:/AFW_M_Event_Free:

Aug 10 15:32:50.387: //-1//AFW_:/AFW_M_Event_Free: Null or invalid event context: for event APP_EV_NULL

Aug 10 15:32:50.387: //1075/1F25020B87B0/SIP/Msg/ccsipDisplayMsg:

Sent:

ACK sip:203@10.160.3.55:5060 SIP/2.0

Via: SIP/2.0/UDP 10.160.3.56:5060;branch=z9hG4bK291126

From: <sip:10.160.3.56>;tag=1EDF491C-1CC5

To: <sip:202@10.160.3.55>;tag=1EAE6ABC-1275

Date: Mon, 10 Aug 2015 13:32:46 GMT

Call-ID: 1F280ED2-3E9B11E5-87B3C175-851B1C9E@10.160.3.56

Max-Forwards: 70

CSeq: 102 ACK

Allow-Events: telephone-event

Content-Length: 0

Aug 10 15:32:50.387: //-1//AFW_:/AFW_Event_New: Event ID: ev_any_event

Aug 10 15:32:50.387: //-1//AFW_:/AFW_M_Event_Free:

Aug 10 15:32:50.387: //-1//AFW_:/AFW_M_Event_Free: Null or invalid event context: for event APP_EV_NULL

Re: What is the operation of callInfo(rerouteMode) ?

Raghavendra G V — Tue, 11 Aug 2015 04:53:42 GMT

I tried your script with NONE, i did received the status code(ls_026).In your log rerouteMode set as rotary. looks like CallInfo

passing to leg setup is different than the variable.

Your log

Aug 10 15:32:46.800: //-1//AFW_:EE67B8F67C000:/AFW_FSM_Drive: ACTION BEGIN: ------(I[1],ev_session_indication[198])---[sess]------
Aug 10 15:32:46.800: //-1//TCL :EE67B8F67C000:/tcl_LegObjCmd: leg setup 202 callinfo
Aug 10 15:32:46.800: //-1//CSPK:EE67B8F67C000:/tcl_LegSetupObjCmd: leg setup 202 callinfo
Aug 10 15:32:46.804: //-1//CSPK:EE67B8F67C000:/C_CallSetup_Start: ControlInfo = 0x69FE6480, callInfo = 0x69F9C774, destination[0]=202
Aug 10 15:32:46.804: //-1//CSPK:EE67B8F67C000:/C_CallSetup_Start: configured mode=rotary (1)
Aug 10 15:32:46.804: //-1//CSPK:EE67B8F67C000:/C_CallSetup_Start: configured reroutemode=rotary (1)

My log

*Aug 11 04:49:28.116: //-1//AFW_:EE4F02F014000:/AFW_FSM_Drive: ACTION BEGIN: ------(I[1],ev_session_indication[195])---[sess]------
*Aug 11 04:49:28.116: //-1//TCL :EE4F02F014000:/tcl_LegObjCmd: leg setup 300 callInfo
*Aug 11 04:49:28.116: //-1//CSPK:EE4F02F014000:/tcl_LegSetupObjCmd: leg setup 300 callInfo
*Aug 11 04:49:28.116: //-1//CSPK:/tclSetControlParams: rerouteMode(5) = NONE
*Aug 11 04:49:28.116: //-1//CSPK:EE4F02F014000:/C_CallSetup_Start: ControlInfo = 0x4F04D090, callInfo = 0x4F047780, destination[0]=300
*Aug 11 04:49:28.116: //-1//CSPK:EE4F02F014000:/C_CallSetup_Start: configured mode=rotary (1)

Thanks,
Raghavendra

Re: What is the operation of callInfo(rerouteMode) ?

paolo bevilacqua — Tue, 11 Aug 2015 09:21:30 GMT

Which IOS version are you using? Can you try 15.2(4)M9 ?

Re: What is the operation of callInfo(rerouteMode) ?

Raghavendra G V — Tue, 11 Aug 2015 09:27:21 GMT

I tried in 151-4.M1.

Thanks,

Raghavendra

Re: What is the operation of callInfo(rerouteMode) ?

paolo bevilacqua — Tue, 11 Aug 2015 12:34:48 GMT

Can you try 15.1(4)M10 which has ED status ?

Cisco.com does not allow to dowload 15.1(4)M1 with the following message, followed by a long list of bugs-

Cisco engineering has identified at least one serious software issue with the release which you have selected that may affect your use of these software.