show monitor event-trace voip ccsip (EXEC)
To display the captured Voice over IP (VoIP) Call-Control Session Initiation Protocol (CCSIP) event-traces on console, use the show monitor event-trace voip ccsip command in user EXEC or privileged EXEC mode.
show monitor event-trace voip ccsip {api | fsm | global | history | merged | misc | msg | summary} [filter {call-id | called-num | calling-num | sip-call-id} filter] {all | back duration | clock time | from-boot seconds | latest}
Syntax Description
api |
Displays information about event tracing for VOIP CCSIP API events. |
fsm |
Displays information about event tracing for Finite State Machine (FSM) and Communicating Nested FSM (CNFSM) events. |
global |
Displays information about event tracing for global events. |
history |
Displays information about all completed calls. |
merged |
Displays information about merged events. |
misc |
Displays information about miscellaneous events. |
msg |
Displays information about event tracing message events. |
summary |
Displays a summary of all captured information. |
filter |
(Optional) Filters information to be displayed based on the selected filter options. |
call-id filter |
Displays information related to the specified call ID. |
called-num filter |
Displays information related to the specified called number. |
calling-num filter |
Displays information related to the specified calling number. |
sip-call-id filter |
Displays information related to the specified SIP call-id. |
all |
Displays all event trace information in the current buffer. |
back duration |
Displays all event trace information from the current time going backwards for the duration specified. |
clock time |
Displays information from the specified time until the current time. |
from-boot seconds |
Displays information from this many seconds after boot. |
latest |
Displays the latest trace events since the last display. |
Command Modes
User EXEC (>)
Privileged EXEC (#)
Command History
Release | Modification |
---|---|
15.3(3)M |
This command was introduced. |
Usage Guidelines
Use the monitor event-trace voip ccsip command to control what, when, and how event trace data is collected. Use this command after you have configured the event trace functionality on the networking device using the monitor event-trace voip ccsip command in global configuration mode.
Use the show monitor event-trace voip ccsip command to display event traces for the configured events.
Use the filter keyword to limit traces for specific SIP based parameters, this ensures that only relevant traces are displayed on the console.
Examples
The following example shows how to display a summary of statistics for active call traces:
Device# show monitor event-trace voip ccsip summary
--------Cover buff----------
buffer-id = 1 ccCallId = 1 PeerCallId = 2
Called-Number = 22222 Calling-Number = 11111 Sip-Call-Id = 1-5671@9.40.1.22
sip_msgs: Enabled.. Total Traces logged = 8
sip_fsm: Enabled.. Total Traces logged = 22
sip_apis: Enabled.. Total Traces logged = 15
sip_misc: Enabled.. Total Traces logged = 4
--------Cover buff----------
buffer-id = 2 ccCallId = 2 PeerCallId = 1
Called-Number = 22222 Calling-Number = 11111 Sip-Call-Id = 7155B639-FFFFFFFFE25011E2-FFFFFFFF80088694-20A3250E@9.40.1.30
sip_msgs: Enabled.. Total Traces logged = 7
sip_fsm: Enabled.. Total Traces logged = 26
sip_apis: Enabled.. Total Traces logged = 19
sip_misc: Enabled.. Total Traces logged = 3
The following example shows how to display information about all miscellaneous event traces:
Device# show monitor event-trace voip ccsip misc all
--------Cover buff----------
buffer-id = 1 ccCallId = 1 PeerCallId = 2
Called-Number = 22222 Calling-Number = 11111 Sip-Call-Id = 1-5671@9.40.1.22
sip_msgs: Enabled.. Total Traces logged = 8
sip_fsm: Enabled.. Total Traces logged = 22
sip_apis: Enabled.. Total Traces logged = 15
sip_misc: Enabled.. Total Traces logged = 4
--------------------------------
*Jul 2 13:16:30.118: Inbound dial-peer matched : tag = 11111
*Jul 2 13:16:30.119: Media Stream Index = 1, Media Stream Type = voice-only Stream State = STREAM_ADDING
Negotiated Codec = g711ulaw Negotiated DTMF Type = inband-voice
*Jul 2 13:16:30.120: Media Stream Index = 1, Media Stream Type = voice-only Stream State = STREAM_ADDING
Negotiated Codec = g711ulaw Negotiated DTMF Type = inband-voice
*Jul 2 13:16:30.131: Media Stream Index = 1, Media Stream Type = voice-only Stream State = STREAM_ADDING
Negotiated Codec = g711ulaw Negotiated DTMF Type = inband-voice
--------Cover buff----------
buffer-id = 2 ccCallId = 2 PeerCallId = 1
Called-Number = 22222 Calling-Number = 11111 Sip-Call-Id = 7155B639-FFFFFFFFE25011E2-FFFFFFFF80088694-20A3250E@9.40.1.30
sip_msgs: Enabled.. Total Traces logged = 7
sip_fsm: Enabled.. Total Traces logged = 26
sip_apis: Enabled.. Total Traces logged = 19
sip_misc: Enabled.. Total Traces logged = 3
--------------------------------
*Jul 2 13:16:30.122: Outbound dial-peer matched : tag = 22222
*Jul 2 13:16:30.123: Media Stream Index = 1, Media Stream Type = voice-only Stream State = STREAM_ADDING
Negotiated Codec = No Codec Negotiated DTMF Type = inband-voice
*Jul 2 13:16:30.129: Media Stream Index = 1, Media Stream Type = voice-only Stream State = STREAM_ADDING
Negotiated Codec = g711ulaw Negotiated DTMF Type = inband-voice
The following example displays the captured event traces for Finite State Machine (FSM) and Communicating Nested FSM (CNFSM) events:
Device# show monitor event-trace voip ccsip fsm all
--------Cover buff----------
buffer-id = 1 ccCallId = 1 PeerCallId = 2
Called-Number = 22222 Calling-Number = 11111 Sip-Call-Id = 1-5671@9.40.1.22
sip_msgs: Enabled.. Total Traces logged = 8
sip_fsm: Enabled.. Total Traces logged = 22
sip_apis: Enabled.. Total Traces logged = 15
sip_misc: Enabled.. Total Traces logged = 4
--------------------------------
*Jul 2 13:16:30.116: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_NONE Next State = STATE_IDLE Current Substate = STATE_NONE Next Substate = STATE_IDLE
*Jul 2 13:16:30.118: CNFSM TYPE = SIP Offer-Answer CNFSM, Event = E_SIP_INVITE_SDP_RCVD, Current State = S_SIP_EARLY_DIALOG_IDLE, Next State = S_SIP_EARLY_DIALOG_OFFER_RCVD
*Jul 2 13:16:30.118: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_RCVD_SDP, Current State = S_SIP_IWF_SDP_IDLE, Next State = S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT
*Jul 2 13:16:30.119: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_IDLE Next State = STATE_RECD_INVITE Current Substate = STATE_IDLE Next Substate = STATE_RECD_INVITE
*Jul 2 13:16:30.121: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_SET_MODE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.122: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_CC_CALL_PROCEEDING Current State = STATE_RECD_INVITE
*Jul 2 13:16:30.122: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_XCODER_RESET_STREAM, Current State = CNFSM_CONTAINER_STATE, Next State = S_IPIP_MEDIA_SERV_STATE_IDLE
*Jul 2 13:16:30.127: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_CC_CALL_ALERTING Current State = STATE_RECD_INVITE
*Jul 2 13:16:30.127: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_RECD_INVITE Next State = STATE_SENT_ALERTING Current Substate = STATE_RECD_INVITE Next Substate = STATE_SENT_ALERTING
*Jul 2 13:16:30.128: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_PEER_CAPS, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.130: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_PEER_MULTIMEDIA_CHANNEL_ACK, Current State = S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.130: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_PEER_CHNL_ACK, Current State = S_IPIP_MEDIA_SERV_STATE_IDLE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.139: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_CALL_CONNECT, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.139: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_CC_CALL_CONNECT Current State = STATE_SENT_ALERTING
*Jul 2 13:16:30.139: CNFSM TYPE = SIP Offer-Answer CNFSM, Event = E_SIP_INVITE_RESP_SDP_SENT, Current State = S_SIP_EARLY_DIALOG_OFFER_RCVD, Next State = S_SIP_EARLY_DIALOG_OFFER_ANSWER_COMPLETE
*Jul 2 13:16:30.139: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_SENT_SDP, Current State = S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT, Next State = S_SIP_IWF_SDP_DONE
*Jul 2 13:16:30.141: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_SENT_ALERTING Next State = STATE_SENT_SUCCESS Current Substate = STATE_SENT_ALERTING Next Substate = STATE_SENT_SUCCESS
*Jul 2 13:16:30.146: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_NEW_MESSAGE Current State = STATE_SENT_SUCCESS
*Jul 2 13:16:30.146: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_SENT_SUCCESS Next State = STATE_ACTIVE Current Substate = STATE_SENT_SUCCESS Next Substate = STATE_ACTIVE
*Jul 2 13:16:30.146: CNFSM TYPE = SIP Offer-Answer CNFSM, Event = E_SIP_DIALOG_ESTD, Current State = S_SIP_EARLY_DIALOG_OFFER_ANSWER_COMPLETE, Next State = S_SIP_MID_DIALOG_IDLE
*Jul 2 13:16:30.146: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_CALL_ACTIVE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.147: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_CALL_ACTIVE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
--------Cover buff----------
buffer-id = 2 ccCallId = 2 PeerCallId = 1
Called-Number = 22222 Calling-Number = 11111 Sip-Call-Id = 7155B639-FFFFFFFFE25011E2-FFFFFFFF80088694-20A3250E@9.40.1.30
sip_msgs: Enabled.. Total Traces logged = 7
sip_fsm: Enabled.. Total Traces logged = 26
sip_apis: Enabled.. Total Traces logged = 19
sip_misc: Enabled.. Total Traces logged = 3
--------------------------------
*Jul 2 13:16:30.121: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_NONE Next State = STATE_IDLE Current Substate = STATE_NONE Next Substate = STATE_IDLE
*Jul 2 13:16:30.121: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_SET_MODE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.121: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_PRE_SETUP, Current State = S_SIP_IWF_SDP_IDLE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.122: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_PEER_MULTIMEDIA_CHANNEL_IND, Current State = S_SIP_IWF_SDP_IDLE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.122: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_PEER_CHNL_IND, Current State = S_IPIP_MEDIA_SERV_STATE_IDLE, Next State = S_IPIP_MEDIA_SERV_STATE_INIT_XCODER_RESERVED
*Jul 2 13:16:30.122: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_CONTINUE_PRE_SETUP, Current State = S_SIP_IWF_SDP_IDLE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.123: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_XCODER_RESET_STREAM, Current State = CNFSM_CONTAINER_STATE, Next State = S_IPIP_MEDIA_SERV_STATE_IDLE
*Jul 2 13:16:30.123: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_INIT_CALL_SETUP, Current State = S_SIP_IWF_SDP_IDLE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.123: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_CC_CALL_SETUP Current State = STATE_IDLE
*Jul 2 13:16:30.124: CNFSM TYPE = SIP Offer-Answer CNFSM, Event = E_SIP_INVITE_SDP_SENT, Current State = S_SIP_EARLY_DIALOG_IDLE, Next State = S_SIP_EARLY_DIALOG_OFFER_SENT
*Jul 2 13:16:30.124: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_SENT_SDP, Current State = S_SIP_IWF_SDP_IDLE, Next State = S_SIP_IWF_SDP_SENT_AWAIT_SDP
*Jul 2 13:16:30.125: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_IDLE Next State = STATE_SENT_INVITE Current Substate = STATE_IDLE Next Substate = STATE_SENT_INVITE
*Jul 2 13:16:30.127: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_NEW_MESSAGE Current State = STATE_SENT_INVITE
*Jul 2 13:16:30.127: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_SENT_INVITE Next State = STATE_RECD_PROCEEDING Current Substate = STATE_SENT_INVITE Next Substate = STATE_RECD_PROCEEDING
*Jul 2 13:16:30.128: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_NEW_MESSAGE Current State = STATE_RECD_PROCEEDING
*Jul 2 13:16:30.128: CNFSM TYPE = SIP Offer-Answer CNFSM, Event = E_SIP_INVITE_RESP_SDP_RCVD, Current State = S_SIP_EARLY_DIALOG_OFFER_SENT, Next State = S_SIP_EARLY_DIALOG_OFFER_ANSWER_COMPLETE
*Jul 2 13:16:30.128: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_RCVD_SDP, Current State = S_SIP_IWF_SDP_SENT_AWAIT_SDP, Next State = S_SIP_IWF_SDP_DONE
*Jul 2 13:16:30.129: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_RECD_PROCEEDING Next State = STATE_RECD_PROCEEDING Current Substate = STATE_RECD_PROCEEDING Next Substate = STATE_RECD_PROCEEDING
*Jul 2 13:16:30.129: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_RECD_PROCEEDING Next State = SIP_STATE_RECD_SUCCESS Current Substate = STATE_RECD_PROCEEDING Next Substate = SIP_STATE_RECD_SUCCESS
*Jul 2 13:16:30.129: CNFSM TYPE = SIP Offer-Answer CNFSM, Event = E_SIP_DIALOG_ESTD, Current State = S_SIP_EARLY_DIALOG_OFFER_ANSWER_COMPLETE, Next State = S_SIP_MID_DIALOG_IDLE
*Jul 2 13:16:30.129: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_CALL_ACTIVE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.129: FSM TYPE = SIP STATE TRANS FSM Current State = SIP_STATE_RECD_SUCCESS Next State = STATE_ACTIVE Current Substate = SIP_STATE_RECD_SUCCESS Next Substate = STATE_ACTIVE
*Jul 2 13:16:30.129: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_UPDATE_STREAM_CONTEXT, Current State = S_SIP_IWF_SDP_DONE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.130: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_PEER_CAPS_ACK,, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.130: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_PEER_CAPS_ACK,, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.130: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_CALL_ACTIVE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
The following example shows how to display information about all API event traces:
Device# show monitor event-trace voip ccsip api all
--------Cover buff----------
buffer-id = 1 ccCallId = 1 PeerCallId = 2
Called-Number = 22222 Calling-Number = 11111 Sip-Call-Id = 1-5671@9.40.1.22
sip_msgs: Enabled.. Total Traces logged = 8
sip_fsm: Enabled.. Total Traces logged = 22
sip_apis: Enabled.. Total Traces logged = 15
sip_misc: Enabled.. Total Traces logged = 4
--------------------------------
*Jul 2 13:16:30.119: API Name = cc_api_update_interface_cac_resource Ret_code= 0
*Jul 2 13:16:30.119: API Name = voip_rtp_allocate_port Port = 16384
*Jul 2 13:16:30.120: API Name = cc_api_call_setup_ind_with_callID Ret_code= 0
*Jul 2 13:16:30.123: API Name = voip_rtp_create_session Ret_code= 0
*Jul 2 13:16:30.123: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.123: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.129: API Name = cc_api_caps_ack Ret_code= 0
*Jul 2 13:16:30.130: API Name = cc_api_caps_ack Ret_code= 0
*Jul 2 13:16:30.131: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: API Name = cc_api_call_mode_update_ind Ret_code= 0
*Jul 2 13:16:30.132: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.132: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.132: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.132: API Name = cc_api_bridge_done Ret_code= 0
*Jul 2 13:16:30.132: API Name = ccsip_bridge Ret_code= 0
--------Cover buff----------
buffer-id = 2 ccCallId = 2 PeerCallId = 1
Called-Number = 22222 Calling-Number = 11111 Sip-Call-Id = 7155B639-FFFFFFFFE25011E2-FFFFFFFF80088694-20A3250E@9.40.1.30
sip_msgs: Enabled.. Total Traces logged = 7
sip_fsm: Enabled.. Total Traces logged = 26
sip_apis: Enabled.. Total Traces logged = 19
sip_misc: Enabled.. Total Traces logged = 3
--------------------------------
*Jul 2 13:16:30.122: API Name = voip_rtp_allocate_port Port = 16386
*Jul 2 13:16:30.122: API Name = voip_rtp_create_session Ret_code= 0
*Jul 2 13:16:30.122: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.123: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.124: API Name = cc_api_update_interface_cac_resource Ret_code= 0
*Jul 2 13:16:30.124: API Name = cc_api_call_proceeding Ret_code= 0
*Jul 2 13:16:30.126: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.126: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.126: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.128: API Name = cc_api_call_alert Ret_code= 0
*Jul 2 13:16:30.128: API Name = cc_api_call_mode_update_ind Ret_code= 0
*Jul 2 13:16:30.129: API Name = cc_api_caps_ind Ret_code= 0
*Jul 2 13:16:30.129: API Name = cc_api_call_connected Ret_code= 0
*Jul 2 13:16:30.129: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.131: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: API Name = cc_api_bridge_done Ret_code= 0
*Jul 2 13:16:30.131: API Name = ccsip_bridge Ret_code= 0
--------Cover buff----------
buffer-id = 3 ccCallId = 3 PeerCallId = 4
Called-Number = 44444 Calling-Number = 33333 Sip-Call-Id = 1-5682@9.40.1.22
sip_msgs: Enabled.. Total Traces logged = 8
sip_fsm: Enabled.. Total Traces logged = 22
sip_apis: Enabled.. Total Traces logged = 15
sip_misc: Enabled.. Total Traces logged = 4
--------------------------------
*Jul 2 13:21:40.322: API Name = cc_api_update_interface_cac_resource Ret_code= 0
*Jul 2 13:21:40.322: API Name = voip_rtp_allocate_port Port = 16388
*Jul 2 13:21:40.322: API Name = cc_api_call_setup_ind_with_callID Ret_code= 0
*Jul 2 13:21:40.324: API Name = voip_rtp_create_session Ret_code= 0
*Jul 2 13:21:40.324: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:21:40.324: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:21:40.330: API Name = cc_api_caps_ack Ret_code= 0
*Jul 2 13:21:40.331: API Name = cc_api_caps_ack Ret_code= 0
*Jul 2 13:21:40.333: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:21:40.333: API Name = cc_api_call_mode_update_ind Ret_code= 0
*Jul 2 13:21:40.333: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:21:40.333: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:21:40.334: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:21:40.334: API Name = cc_api_bridge_done Ret_code= 0
*Jul 2 13:21:40.332: API Name = ccsip_bridge Ret_code= 0
--------Cover buff----------
buffer-id = 4 ccCallId = 4 PeerCallId = 3
Called-Number = 44444 Calling-Number = 33333 Sip-Call-Id = 2A3AEE9D-FFFFFFFFE25111E2-FFFFFFFF800F8694-20A3250E@9.40.1.30
sip_msgs: Enabled.. Total Traces logged = 7
sip_fsm: Enabled.. Total Traces logged = 26
sip_apis: Enabled.. Total Traces logged = 19
sip_misc: Enabled.. Total Traces logged = 3
--------------------------------
*Jul 2 13:21:40.324: API Name = voip_rtp_allocate_port Port = 16390
*Jul 2 13:21:40.326: API Name = voip_rtp_create_session Ret_code= 0
*Jul 2 13:21:40.326: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:21:40.326: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:21:40.327: API Name = cc_api_update_interface_cac_resource Ret_code= 0
*Jul 2 13:21:40.327: API Name = cc_api_call_proceeding Ret_code= 0
*Jul 2 13:21:40.328: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:21:40.327: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:21:40.327: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:21:40.329: API Name = cc_api_call_alert Ret_code= 0
*Jul 2 13:21:40.330: API Name = cc_api_call_mode_update_ind Ret_code= 0
*Jul 2 13:21:40.331: API Name = cc_api_caps_ind Ret_code= 0
*Jul 2 13:21:40.331: API Name = cc_api_call_connected Ret_code= 0
*Jul 2 13:21:40.331: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:21:40.333: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:21:40.333: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:21:40.333: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:21:40.333: API Name = cc_api_bridge_done Ret_code= 0
*Jul 2 13:21:40.333: API Name = ccsip_bridge Ret_code= 0
In the following example, there are two active calls on Cisco UBE. In the first call, the calling number is 1111 and it calls the number 22222. In the second call, the calling number is 33333 and it calls number 44444. The example shows how to filter the API event traces where the calling number is 11111:
Device# show monitor event-trace voip ccsip api filter calling-num 11111 all
--------Cover buff----------
buffer-id = 1 ccCallId = 1 PeerCallId = 2
Called-Number = 22222 Calling-Number = 11111 Sip-Call-Id = 1-5671@9.40.1.22
sip_msgs: Enabled.. Total Traces logged = 8
sip_fsm: Enabled.. Total Traces logged = 22
sip_apis: Enabled.. Total Traces logged = 15
sip_misc: Enabled.. Total Traces logged = 4
--------------------------------
*Jul 2 13:16:30.119: API Name = cc_api_update_interface_cac_resource Ret_code= 0
*Jul 2 13:16:30.119: API Name = voip_rtp_allocate_port Port = 16384
*Jul 2 13:16:30.120: API Name = cc_api_call_setup_ind_with_callID Ret_code= 0
*Jul 2 13:16:30.123: API Name = voip_rtp_create_session Ret_code= 0
*Jul 2 13:16:30.123: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.123: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.129: API Name = cc_api_caps_ack Ret_code= 0
*Jul 2 13:16:30.130: API Name = cc_api_caps_ack Ret_code= 0
*Jul 2 13:16:30.131: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: API Name = cc_api_call_mode_update_ind Ret_code= 0
*Jul 2 13:16:30.131: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.131: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: API Name = cc_api_bridge_done Ret_code= 0
*Jul 2 13:16:30.131: API Name = ccsip_bridge Ret_code= 0
--------Cover buff----------
buffer-id = 2 ccCallId = 2 PeerCallId = 1
Called-Number = 22222 Calling-Number = 11111 Sip-Call-Id = 7155B639-FFFFFFFFE25011E2-FFFFFFFF80088694-20A3250E@9.40.1.30
sip_msgs: Enabled.. Total Traces logged = 7
sip_fsm: Enabled.. Total Traces logged = 26
sip_apis: Enabled.. Total Traces logged = 19
sip_misc: Enabled.. Total Traces logged = 3
--------------------------------
*Jul 2 13:16:30.123: API Name = voip_rtp_allocate_port Port = 16386
*Jul 2 13:16:30.124: API Name = voip_rtp_create_session Ret_code= 0
*Jul 2 13:16:30.124: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.124: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.124: API Name = cc_api_update_interface_cac_resource Ret_code= 0
*Jul 2 13:16:30.124: API Name = cc_api_call_proceeding Ret_code= 0
*Jul 2 13:16:30.126: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.126: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.126: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.128: API Name = cc_api_call_alert Ret_code= 0
*Jul 2 13:16:30.129: API Name = cc_api_call_mode_update_ind Ret_code= 0
*Jul 2 13:16:30.130: API Name = cc_api_caps_ind Ret_code= 0
*Jul 2 13:16:30.129: API Name = cc_api_call_connected Ret_code= 0
*Jul 2 13:16:30.129: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.131: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: API Name = cc_api_bridge_done Ret_code= 0
*Jul 2 13:16:30.131: API Name = ccsip_bridge Ret_code= 0
The following example shows how to display the traces captured for completed calls. The call could be a successful one or a failed one. The output displays all the traces (fsm, msg, misc, api) that were enabled at the time of call, arranged according to time stamp:
Device# show monitor event-trace voip ccsip history all
--------Cover buff----------
buffer-id = 2 ccCallId = 2 PeerCallId = 1
Called-Number = 22222 Calling-Number = 11111 Sip-Call-Id = 7155B639-FFFFFFFFE25011E2-FFFFFFFF80088694-20A3250E@9.40.1.30
sip_msgs: Enabled.. Total Traces logged = 9
sip_fsm: Enabled.. Total Traces logged = 31
sip_apis: Enabled.. Total Traces logged = 25
sip_misc: Enabled.. Total Traces logged = 3
--------------------------------
*Jul 2 13:16:30.122: sip_misc: Outbound dial-peer matched : tag = 22222
*Jul 2 13:16:30.122: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_NONE Next State = STATE_IDLE Current Substate = STATE_NONE Next Substate = STATE_IDLE
*Jul 2 13:16:30.122: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_SET_MODE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.122: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_PRE_SETUP, Current State = S_SIP_IWF_SDP_IDLE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.123: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_PEER_MULTIMEDIA_CHANNEL_IND, Current State = S_SIP_IWF_SDP_IDLE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.123: sip_misc: Media Stream Index = 1, Media Stream Type = voice-only Stream State = STREAM_ADDING
Negotiated Codec = No Codec Negotiated DTMF Type = inband-voice
*Jul 2 13:16:30.122: sip_fsm: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_PEER_CHNL_IND, Current State = S_IPIP_MEDIA_SERV_STATE_IDLE, Next State = S_IPIP_MEDIA_SERV_STATE_INIT_XCODER_RESERVED
*Jul 2 13:16:30.122: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_CONTINUE_PRE_SETUP, Current State = S_SIP_IWF_SDP_IDLE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.123: sip_fsm: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_XCODER_RESET_STREAM, Current State = CNFSM_CONTAINER_STATE, Next State = S_IPIP_MEDIA_SERV_STATE_IDLE
*Jul 2 13:16:30.124: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_INIT_CALL_SETUP, Current State = S_SIP_IWF_SDP_IDLE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.124: sip_apis: API Name = voip_rtp_allocate_port Port = 16386
*Jul 2 13:16:30.124: sip_apis: API Name = voip_rtp_create_session Ret_code= 0
*Jul 2 13:16:30.124: sip_apis: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.124: sip_apis: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.124: sip_apis: API Name = cc_api_update_interface_cac_resource Ret_code= 0
*Jul 2 13:16:30.124: sip_fsm: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_CC_CALL_SETUP Current State = STATE_IDLE
*Jul 2 13:16:30.124: sip_apis: API Name = cc_api_call_proceeding Ret_code= 0
*Jul 2 13:16:30.125: sip_fsm: CNFSM TYPE = SIP Offer-Answer CNFSM, Event = E_SIP_INVITE_SDP_SENT, Current State = S_SIP_EARLY_DIALOG_IDLE, Next State = S_SIP_EARLY_DIALOG_OFFER_SENT
*Jul 2 13:16:30.125: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_SENT_SDP, Current State = S_SIP_IWF_SDP_IDLE, Next State = S_SIP_IWF_SDP_SENT_AWAIT_SDP
*Jul 2 13:16:30.126: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_IDLE Next State = STATE_SENT_INVITE Current Substate = STATE_IDLE Next Substate = STATE_SENT_INVITE
*Jul 2 13:16:30.125: sip_apis: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.125: sip_apis: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.125: sip_apis: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.125: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 3, Last Fragment = No, Messages Direction = Sent, Message:
INVITE sip:22222@9.40.1.22:9632 SIP/2.0
Via: SIP/2.0/UDP 9.40.1.30:5060;branch=z9hG4bK07AC
Remote-Party-ID: "11111 " <sip:11111@9.40.1.30>;party=calling;screen=no;privacy=off
From: "11111 " <sip:11111@9.40.1.30>;tag=38C94-2507
To: <sip:22222@9.40.1.22>
Date: Tue, 02 Jul 2013 13:16:30 GMT
Call-ID: 7155B639-FFFFFFFFE25011E2-FFFFFFFF80088694-20A3250E@9.40.1.30
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE: 1800
Cisco-Guid: 1901362665-3796898274-2147649172-0547562766
--------
*Jul 2 13:16:30.126: sip_msgs: SIP_MSG: Fragment Number = 2, Message Id = 3, Last Fragment = No, Messages Direction = Sent, Message:
User-Agent: Cisco-SIPGateway/IOS-15.3.20130514.122658.
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1372770990
Contact: <sip:11111@9.40.1.30:5060>
Expires: 180
Allow-Events: telephone-event
Max-Forwards: 69
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 206
v=0
o=CiscoSystemsSIP-GW-UserAgent 5243 1933 IN IP4 9.40.1.30
s=SIP Call
c=IN IP4 9.40.1.30
t=0
--------
*Jul 2 13:16:30.126: sip_msgs: SIP_MSG: Fragment Number = 3, Message Id = 3, Last Fragment = Yes, Messages Direction = Sent, Message:
0
m=audio 16386 RTP/AVP 0 19
c=IN IP4 9.40.1.30
a=rtpmap:0 PCMU/8000
a=rtpmap:19 CN/8000
a=ptime:20
--------
*Jul 2 13:16:30.126: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 4, Last Fragment = Yes, Messages Direction = received, Message:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 9.40.1.30:5060;branch=z9hG4bK07AC
From: "11111 " <sip:11111@9.40.1.30>;tag=38C94-2507
To: <sip:22222@9.40.1.22>;tag=4
Call-ID: 7155B639-FFFFFFFFE25011E2-FFFFFFFF80088694-20A3250E@9.40.1.30
CSeq: 101 INVITE
Contact: <sip:9.40.1.22:9632;transport=UDP>
Content-Length: 0
--------
*Jul 2 13:16:30.127: sip_fsm: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_NEW_MESSAGE Current State = STATE_SENT_INVITE
*Jul 2 13:16:30.127: sip_apis: API Name = cc_api_call_alert Ret_code= 0
*Jul 2 13:16:30.128: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_SENT_INVITE Next State = STATE_RECD_PROCEEDING Current Substate = STATE_SENT_INVITE Next Substate = STATE_RECD_PROCEEDING
*Jul 2 13:16:30.128: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 6, Last Fragment = No, Messages Direction = received, Message:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 9.40.1.30:5060;branch=z9hG4bK07AC
From: "11111 " <sip:11111@9.40.1.30>;tag=38C94-2507
To: <sip:22222@9.40.1.22>;tag=4
Call-ID: 7155B639-FFFFFFFFE25011E2-FFFFFFFF80088694-20A3250E@9.40.1.30
CSeq: 101 INVITE
Contact: <sip:9.40.1.22:9632;transport=UDP>
Content-Type: application/sdp
Content-Length: 199
v=0
o=user1 53655765 2353687637 IN IP4 9.40.1.22
s=-
c=IN IP4 9.40.1.22
t=0 0
m=audio 9832 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephon
--------
*Jul 2 13:16:30.128: sip_msgs: SIP_MSG: Fragment Number = 2, Message Id = 6, Last Fragment = Yes, Messages Direction = received, Message:
e-event/8000
a=fmtp:101 0-16
a=ptime:20
--------
*Jul 2 13:16:30.129: sip_fsm: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_NEW_MESSAGE Current State = STATE_RECD_PROCEEDING
*Jul 2 13:16:30.129: sip_fsm: CNFSM TYPE = SIP Offer-Answer CNFSM, Event = E_SIP_INVITE_RESP_SDP_RCVD, Current State = S_SIP_EARLY_DIALOG_OFFER_SENT, Next State = S_SIP_EARLY_DIALOG_OFFER_ANSWER_COMPLETE
*Jul 2 13:16:30.129: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_RCVD_SDP, Current State = S_SIP_IWF_SDP_SENT_AWAIT_SDP, Next State = S_SIP_IWF_SDP_DONE
*Jul 2 13:16:30.128: sip_misc: Media Stream Index = 1, Media Stream Type = voice-only Stream State = STREAM_ADDING
Negotiated Codec = g711ulaw Negotiated DTMF Type = inband-voice
*Jul 2 13:16:30.128: sip_apis: API Name = cc_api_call_mode_update_ind Ret_code= 0
*Jul 2 13:16:30.129: sip_apis: API Name = cc_api_caps_ind Ret_code= 0
*Jul 2 13:16:30.129: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_RECD_PROCEEDING Next State = STATE_RECD_PROCEEDING Current Substate = STATE_RECD_PROCEEDING Next Substate = STATE_RECD_PROCEEDING
*Jul 2 13:16:30.130: sip_apis: API Name = cc_api_call_connected Ret_code= 0
*Jul 2 13:16:30.130: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_RECD_PROCEEDING Next State = SIP_STATE_RECD_SUCCESS Current Substate = STATE_RECD_PROCEEDING Next Substate = SIP_STATE_RECD_SUCCESS
*Jul 2 13:16:30.130: sip_fsm: CNFSM TYPE = SIP Offer-Answer CNFSM, Event = E_SIP_DIALOG_ESTD, Current State = S_SIP_EARLY_DIALOG_OFFER_ANSWER_COMPLETE, Next State = S_SIP_MID_DIALOG_IDLE
*Jul 2 13:16:30.130: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_CALL_ACTIVE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.130: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = SIP_STATE_RECD_SUCCESS Next State = STATE_ACTIVE Current Substate = SIP_STATE_RECD_SUCCESS Next Substate = STATE_ACTIVE
*Jul 2 13:16:30.129: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_UPDATE_STREAM_CONTEXT, Current State = S_SIP_IWF_SDP_DONE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.129: sip_apis: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.130: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_PEER_CAPS_ACK,, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.130: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_PEER_CAPS_ACK,, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.131: sip_fsm: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_CALL_ACTIVE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.131: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 7, Last Fragment = Yes, Messages Direction = Sent, Message:
ACK sip:9.40.1.22:9632;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 9.40.1.30:5060;branch=z9hG4bK113B1
From: "11111 " <sip:11111@9.40.1.30>;tag=38C94-2507
To: <sip:22222@9.40.1.22>;tag=4
Date: Tue, 02 Jul 2013 13:16:30 GMT
Call-ID: 7155B639-FFFFFFFFE25011E2-FFFFFFFF80088694-20A3250E@9.40.1.30
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: telephone-event
Content-Length: 0
--------
*Jul 2 13:16:30.132: sip_apis: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.132: sip_apis: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.132: sip_apis: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.132: sip_apis: API Name = cc_api_bridge_done Ret_code= 0
*Jul 2 13:16:30.132: sip_apis: API Name = ccsip_bridge Ret_code= 0
*Jul 2 13:32:52.831: sip_fsm: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_XCODER_RESET_STREAM, Current State = CNFSM_CONTAINER_STATE, Next State = S_IPIP_MEDIA_SERV_STATE_IDLE
*Jul 2 13:32:52.831: sip_apis: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:32:52.832: sip_apis: API Name = cc_api_bridge_drop_done Ret_code= 0
*Jul 2 13:32:52.833: sip_apis: API Name = cc_api_update_interface_cac_resource Ret_code= 0
*Jul 2 13:32:52.833: sip_fsm: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_CC_CALL_DISCONNECT Current State = STATE_ACTIVE
*Jul 2 13:32:52.833: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_ACTIVE Next State = STATE_DISCONNECTING Current Substate = STATE_ACTIVE Next Substate = STATE_DISCONNECTING
*Jul 2 13:32:52.831: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 21, Last Fragment = Yes, Messages Direction = Sent, Message:
BYE sip:9.40.1.22:9632;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 9.40.1.30:5060;branch=z9hG4bK4326
From: "11111 " <sip:11111@9.40.1.30>;tag=38C94-2507
To: <sip:22222@9.40.1.22>;tag=4
Date: Tue, 02 Jul 2013 13:16:30 GMT
Call-ID: 7155B639-FFFFFFFFE25011E2-FFFFFFFF80088694-20A3250E@9.40.1.30
User-Agent: Cisco-SIPGateway/IOS-15.3.20130514.122658.
Max-Forwards: 70
Timestamp: 1372771972
CSeq: 102 BYE
Reason: Q.850;cause=16
Content-Length: 0
--------
*Jul 2 13:32:52.839: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 22, Last Fragment = Yes, Messages Direction = received, Message:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 9.40.1.30:5060;branch=z9hG4bK4326
From: "11111 " <sip:11111@9.40.1.30>;tag=38C94-2507
To: <sip:22222@9.40.1.22>;tag=4;tag=4
Call-ID: 7155B639-FFFFFFFFE25011E2-FFFFFFFF80088694-20A3250E@9.40.1.30
CSeq: 102 BYE
Contact: <sip:9.40.1.22:9632;transport=UDP>
--------
*Jul 2 13:32:52.838: sip_fsm: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_NEW_MESSAGE Current State = STATE_DISCONNECTING
*Jul 2 13:32:52.838: sip_apis: API Name = voip_rtp_delete_dp_session Ret_code= 0
*Jul 2 13:32:52.851: sip_apis: API Name = ccsip_voip_rtp_fpi_event_handler Ret_code= 0
*Jul 2 13:32:52.851: sip_apis: API Name = cc_api_call_disconnect_done Ret_code= 0
*Jul 2 13:32:52.851: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_DISCONNECTING Next State = STATE_DEAD Current Substate = STATE_DISCONNECTING Next Substate = STATE_DEAD
--------Cover buff----------
buffer-id = 1 ccCallId = 1 PeerCallId = 2
Called-Number = 22222 Calling-Number = 11111 Sip-Call-Id = 1-5671@9.40.1.22
sip_msgs: Enabled.. Total Traces logged = 10
sip_fsm: Enabled.. Total Traces logged = 28
sip_apis: Enabled.. Total Traces logged = 23
sip_misc: Enabled.. Total Traces logged = 4
--------------------------------
*Jul 2 13:16:30.117: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 1, Last Fragment = No, Messages Direction = received, Message:
INVITE sip:22222@9.40.1.30:5060 SIP/2.0
Via: SIP/2.0/UDP 9.40.1.22:9232;branch=z9hG4bK-5671-1-0
From: 11111 <sip:11111@9.40.1.22:9232>;tag=1
To: 22222 <sip:22222@9.40.1.30:5060>
Call-ID: 1-5671@9.40.1.22
CSeq: 1 INVITE
Contact: <sip:11111@9.40.1.22:9232>
Max-Forwards: 70
Subject: Call Spike Testing
Content-Length: 182
Content-Type: application/sdp
v=0
o=- 53655765 2353687637 IN IP4 9.40.1.22
s=-
c=IN IP4 9.40.1.22
t=0 0
m=audio 9432 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpm
--------
*Jul 2 13:16:30.115: sip_msgs: SIP_MSG: Fragment Number = 2, Message Id = 1, Last Fragment = Yes, Messages Direction = received, Message:
ap: 101 telephone-event/8000
a=fmtp:101 0-16
--------
*Jul 2 13:16:30.115: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_NONE Next State = STATE_IDLE Current Substate = STATE_NONE Next Substate = STATE_IDLE
*Jul 2 13:16:30.118: sip_misc: Inbound dial-peer matched : tag = 11111
*Jul 2 13:16:30.119: sip_fsm: CNFSM TYPE = SIP Offer-Answer CNFSM, Event = E_SIP_INVITE_SDP_RCVD, Current State = S_SIP_EARLY_DIALOG_IDLE, Next State = S_SIP_EARLY_DIALOG_OFFER_RCVD
*Jul 2 13:16:30.119: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_RCVD_SDP, Current State = S_SIP_IWF_SDP_IDLE, Next State = S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT
*Jul 2 13:16:30.119: sip_misc: Media Stream Index = 1, Media Stream Type = voice-only Stream State = STREAM_ADDING
Negotiated Codec = g711ulaw Negotiated DTMF Type = inband-voice
*Jul 2 13:16:30.119: sip_apis: API Name = cc_api_update_interface_cac_resource Ret_code= 0
*Jul 2 13:16:30.119: sip_apis: API Name = voip_rtp_allocate_port Port = 16384
*Jul 2 13:16:30.120: sip_misc: Media Stream Index = 1, Media Stream Type = voice-only Stream State = STREAM_ADDING
Negotiated Codec = g711ulaw Negotiated DTMF Type = inband-voice
*Jul 2 13:16:30.119: sip_apis: API Name = cc_api_call_setup_ind_with_callID Ret_code= 0
*Jul 2 13:16:30.119: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_IDLE Next State = STATE_RECD_INVITE Current Substate = STATE_IDLE Next Substate = STATE_RECD_INVITE
*Jul 2 13:16:30.121: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_SET_MODE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.123: sip_apis: API Name = voip_rtp_create_session Ret_code= 0
*Jul 2 13:16:30.123: sip_apis: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.123: sip_apis: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.123: sip_fsm: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_CC_CALL_PROCEEDING Current State = STATE_RECD_INVITE
*Jul 2 13:16:30.123: sip_fsm: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_XCODER_RESET_STREAM, Current State = CNFSM_CONTAINER_STATE, Next State = S_IPIP_MEDIA_SERV_STATE_IDLE
*Jul 2 13:16:30.126: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 2, Last Fragment = Yes, Messages Direction = Sent, Message:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 9.40.1.22:9232;branch=z9hG4bK-5671-1-0
From: 11111 <sip:11111@9.40.1.22:9232>;tag=1
To: 22222 <sip:22222@9.40.1.30:5060>
Date: Tue, 02 Jul 2013 13:16:30 GMT
Call-ID: 1-5671@9.40.1.22
CSeq: 1 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-15.3.20130514.122658.
Content-Length: 0
--------
*Jul 2 13:16:30.127: sip_fsm: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_CC_CALL_ALERTING Current State = STATE_RECD_INVITE
*Jul 2 13:16:30.127: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_RECD_INVITE Next State = STATE_SENT_ALERTING Current Substate = STATE_RECD_INVITE Next Substate = STATE_SENT_ALERTING
*Jul 2 13:16:30.128: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 5, Last Fragment = No, Messages Direction = Sent, Message:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 9.40.1.22:9232;branch=z9hG4bK-5671-1-0
From: 11111 <sip:11111@9.40.1.22:9232>;tag=1
To: 22222 <sip:22222@9.40.1.30:5060>;tag=38C97-1057
Date: Tue, 02 Jul 2013 13:16:30 GMT
Call-ID: 1-5671@9.40.1.22
CSeq: 1 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
Allow-Events: telephone-event
Remote-Party-ID: <sip:22222@9.40.1.30>;party=called;screen=no;privacy=off
Contact: <sip:22222@9.40.1.30:5060>
--------
*Jul 2 13:16:30.128: sip_msgs: SIP_MSG: Fragment Number = 2, Message Id = 5, Last Fragment = Yes, Messages Direction = Sent, Message:
Server: Cisco-SIPGateway/IOS-15.3.20130514.122658.
Content-Length: 0
--------
*Jul 2 13:16:30.129: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_PEER_CAPS, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.129: sip_apis: API Name = cc_api_caps_ack Ret_code= 0
*Jul 2 13:16:30.130: sip_apis: API Name = cc_api_caps_ack Ret_code= 0
*Jul 2 13:16:30.131: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_PEER_MULTIMEDIA_CHANNEL_ACK, Current State = S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.131: sip_misc: Media Stream Index = 1, Media Stream Type = voice-only Stream State = STREAM_ADDING
Negotiated Codec = g711ulaw Negotiated DTMF Type = inband-voice
*Jul 2 13:16:30.131: sip_apis: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: sip_apis: API Name = cc_api_call_mode_update_ind Ret_code= 0
*Jul 2 13:16:30.131: sip_fsm: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_PEER_CHNL_ACK, Current State = S_IPIP_MEDIA_SERV_STATE_IDLE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.132: sip_apis: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: sip_apis: API Name = voip_rtp_set_non_rtp_call Ret_code= 0
*Jul 2 13:16:30.131: sip_apis: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:16:30.131: sip_apis: API Name = cc_api_bridge_done Ret_code= 0
*Jul 2 13:16:30.131: sip_apis: API Name = ccsip_bridge Ret_code= 0
*Jul 2 13:16:30.139: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_CALL_CONNECT, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.140: sip_fsm: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_CC_CALL_CONNECT Current State = STATE_SENT_ALERTING
*Jul 2 13:16:30.140: sip_fsm: CNFSM TYPE = SIP Offer-Answer CNFSM, Event = E_SIP_INVITE_RESP_SDP_SENT, Current State = S_SIP_EARLY_DIALOG_OFFER_RCVD, Next State = S_SIP_EARLY_DIALOG_OFFER_ANSWER_COMPLETE
*Jul 2 13:16:30.140: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_SENT_SDP, Current State = S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT, Next State = S_SIP_IWF_SDP_DONE
*Jul 2 13:16:30.141: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_SENT_ALERTING Next State = STATE_SENT_SUCCESS Current Substate = STATE_SENT_ALERTING Next Substate = STATE_SENT_SUCCESS
*Jul 2 13:16:30.141: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 8, Last Fragment = No, Messages Direction = Sent, Message:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 9.40.1.22:9232;branch=z9hG4bK-5671-1-0
From: 11111 <sip:11111@9.40.1.22:9232>;tag=1
To: 22222 <sip:22222@9.40.1.30:5060>;tag=38C97-1057
Date: Tue, 02 Jul 2013 13:16:30 GMT
Call-ID: 1-5671@9.40.1.22
CSeq: 1 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
Allow-Events: telephone-event
Remote-Party-ID: <sip:22222@9.40.1.30>;party=called;screen=no;privacy=off
Contact: <sip:22222@9.40.1.30:5060>
Suppo
--------
*Jul 2 13:16:30.142: sip_msgs: SIP_MSG: Fragment Number = 2, Message Id = 8, Last Fragment = Yes, Messages Direction = Sent, Message:
rted: replaces
Supported: sdp-anat
Server: Cisco-SIPGateway/IOS-15.3.20130514.122658.
Supported: timer
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 182
v=0
o=CiscoSystemsSIP-GW-UserAgent 8289 9144 IN IP4 9.40.1.30
s=SIP Call
c=IN IP4 9.40.1.30
t=0 0
m=audio 16384 RTP/AVP 0
c=IN IP4 9.40.1.30
a=rtpmap:0 PCMU/8000
a=ptime:20
--------
*Jul 2 13:16:30.146: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 9, Last Fragment = Yes, Messages Direction = received, Message:
ACK sip:22222@9.40.1.30:5060 SIP/2.0
Via: SIP/2.0/UDP 9.40.1.22:9232;branch=z9hG4bK-5671-1-4
From: 11111 <sip:11111@9.40.1.22:9232>;tag=1
To: 22222 <sip:22222@9.40.1.30:5060>;tag=38C97-1057
Call-ID: 1-5671@9.40.1.22
CSeq: 1 ACK
Contact: sip:11111@9.40.1.22:9232
Max-Forwards: 70
Subject: Performance Test
Content-Type: application/sdp
--------
*Jul 2 13:16:30.146: sip_fsm: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_NEW_MESSAGE Current State = STATE_SENT_SUCCESS
*Jul 2 13:16:30.146: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_SENT_SUCCESS Next State = STATE_ACTIVE Current Substate = STATE_SENT_SUCCESS Next Substate = STATE_ACTIVE
*Jul 2 13:16:30.146: sip_fsm: CNFSM TYPE = SIP Offer-Answer CNFSM, Event = E_SIP_DIALOG_ESTD, Current State = S_SIP_EARLY_DIALOG_OFFER_ANSWER_COMPLETE, Next State = S_SIP_MID_DIALOG_IDLE
*Jul 2 13:16:30.147: sip_fsm: CNFSM TYPE = SIP IWF CNFSM, Event = E_SIP_IWF_EV_CALL_ACTIVE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:16:30.148: sip_fsm: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_CALL_ACTIVE, Current State = CNFSM_CONTAINER_STATE, Next State = CNFSM_NO_STATE_CHANGE
*Jul 2 13:32:52.829: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 19, Last Fragment = Yes, Messages Direction = received, Message:
BYE sip:22222@9.40.1.30:5060 SIP/2.0
Via: SIP/2.0/UDP 9.40.1.22:9232;branch=z9hG4bK-5671-1--1
From: 11111 <sip:11111@9.40.1.22:9232>;tag=1
To: 22222 <sip:22222@9.40.1.30:5060>;tag=38C97-1057
Call-ID: 1-5671@9.40.1.22
CSeq: 2 BYE
Max-Forwards: 70
Contact: <sip:9.40.1.22:9232;transport=UDP>
Content-Length: 0
--------
*Jul 2 13:32:52.829: sip_fsm: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_NEW_MESSAGE Current State = STATE_ACTIVE
*Jul 2 13:32:52.830: sip_apis: API Name = cc_api_call_disconnected Ret_code= 0
*Jul 2 13:32:52.830: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_ACTIVE Next State = STATE_DISCONNECTING Current Substate = STATE_ACTIVE Next Substate = STATE_DISCONNECTING
*Jul 2 13:32:52.830: sip_apis: API Name = voip_rtp_destroy_dp_session Ret_code= 0
*Jul 2 13:32:52.830: sip_fsm: CNFSM TYPE = SIP Media Service CNFSM, Event = E_IPIP_MEDIA_SERV_EV_XCODER_RESET_STREAM, Current State = CNFSM_CONTAINER_STATE, Next State = S_IPIP_MEDIA_SERV_STATE_IDLE
*Jul 2 13:32:52.831: sip_apis: API Name = voip_rtp_update_callinfo Ret_code= 0
*Jul 2 13:32:52.831: sip_apis: API Name = cc_api_bridge_drop_done Ret_code= 0
*Jul 2 13:32:52.831: sip_apis: API Name = cc_api_update_interface_cac_resource Ret_code= 0
*Jul 2 13:32:52.831: sip_fsm: FSM TYPE = SIP Event-state FSM, Event = SIPSPI_EV_CC_CALL_DISCONNECT Current State = STATE_DISCONNECTING
*Jul 2 13:32:52.832: sip_apis: API Name = voip_rtp_delete_dp_session Ret_code= 0
*Jul 2 13:32:52.831: sip_msgs: SIP_MSG: Fragment Number = 1, Message Id = 20, Last Fragment = Yes, Messages Direction = Sent, Message:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 9.40.1.22:9232;branch=z9hG4bK-5671-1--1
From: 11111 <sip:11111@9.40.1.22:9232>;tag=1
To: 22222 <sip:22222@9.40.1.30:5060>;tag=38C97-1057
Date: Tue, 02 Jul 2013 13:32:52 GMT
Call-ID: 1-5671@9.40.1.22
Server: Cisco-SIPGateway/IOS-15.3.20130514.122658.
CSeq: 2 BYE
Reason: Q.850;cause=16
Content-Length: 0
--------
*Jul 2 13:32:52.851: sip_apis: API Name = ccsip_voip_rtp_fpi_event_handler Ret_code= 0
*Jul 2 13:32:52.851: sip_apis: API Name = cc_api_call_disconnect_done Ret_code= 0
*Jul 2 13:32:52.851: sip_fsm: FSM TYPE = SIP STATE TRANS FSM Current State = STATE_DISCONNECTING Next State = STATE_DEAD Current Substate = STATE_DISCONNECTING Next Substate = STATE_DEAD
*Jul 2 13:33:24.851: sip_fsm: FSM TYPE = SIP Timer-STate FSM, Event = SIP_TIMER_REMOVE_TRANSACTION Current State = STATE_DEAD
Field Name | Description |
---|---|
Called-Number |
The destination number. |
Calling-Number |
The number that originated the call. |
Sip-Call-Id |
The SIP call ID. |
Total Traces logged |
The total number of traces logged for the specified message type. |
buffer-id |
The buffer ID uniquely identifies the buffer in which the traces are stored. |
ccCallId |
The call-id of the leg whose traces are displayed. |
PeerCallId |
The remote party call-id |