| 50.7. CTISIP diagnostics, statistics, logs and debug | ||
|---|---|---|
 | Chapter 50. SIP - Session Initiation Protocol |  |
| 50.7. CTISIP diagnostics, statistics, logs and debug | ||
|---|---|---|
| | Chapter 50. SIP - Session Initiation Protocol | |
To display the diagnostics of the CTISIP resource the following commands are used:
Shows diagnostic information, such as the state of the resource, the currently used channels, the remote SIP username, the local/remote IP address-port of the SIP channel for incoming packets, the calling and the called number.
Shows diagnostic information in an extended format: the same information listed for d d ctisip command and the state of Unattended/Attended Call Transfer, the local/remote IP address-port of the SIP channel for outgoing packets, the local/remote IP address-port for RTP and RTCP channel.
[12:34:34] ABILIS_CPX:d d ctisip
RES:CtiSip --------------------------------------------------------------------
Session_Initiation_Protocol
STATE:ACTIVE UDP-STATE:CLOSED USED-CHAN:0
- SIP Channels diagnostics ---------------------------------------------
CH: SIPState Prot TcpLsn SIP-LocAdd-Port-In SIP-RemAdd-Port-In
Q931State CG CD
User CallId
------------------------------------------------------------------------
0 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
1 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
2 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
3 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
4 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
5 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
6 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
7 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
8 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
9 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------[12:34:34] ABILIS_CPX:d de ctisip
RES:CtiSip --------------------------------------------------------------------
Session_Initiation_Protocol
STATE:ACTIVE UDP-STATE:CLOSED USED-CHAN:0
- SIP Channels diagnostics ---------------------------------------------
CH: SIPState Prot TcpLsn SIPLocAdd-Port-In SIPRemAdd-Port-In
SIPLocAdd-Port-Out SIPRemAdd-Port-Out
Q931State CG CD
User CallId
Q932State UCTState ACTState CPOState
RTPState RTPLocAdd-LocPort RTPRemAdd-RemPort
RTCPState RTCPLocAdd-LocPort RTCPRemAdd-RemPort
------------------------------------------------------------------------
0 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
1 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
2 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
3 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
4 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
5 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
6 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
7 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
8 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------
9 DISCONNECTED
00-DISCONNECTED
------------------------------------------------------------------------To display the statistics of the CTISIP resource the following commands are used:
Shows statistic information, such as the number of incoming/outgoing accepted/rejected calls, the number of incoming/outgoing succesful/failed registrations, the number of incoming/outgoing reinvites, the number of successful incoming/outgoing transfers, the number of expired retransmission timer in incoming/outgoing calls.
Shows statistic information in an extended format: the same information listed for d se ctisip command are shown for each session.
[12:34:34] ABILIS_CPX:d s ctisip
RES:CtiSip --------------------------------------------------------------------
Session_Initiation_Protocol
--- Cleared 0 days 19:38:23 ago, on 28/05/2015 at 19:48:21 -------------
-----------|---INPUT---|--OUTPUT---|-----------|---INPUT---|--OUTPUT---|
SUCC-CALL | 0| 0|FAIL-CALL | 0| 0|
SUCC-REG | 0| 1843|FAIL-REG | 0| 0|
SUCC-SUB | 0| |FAIL-SUB | 0| |
SUCC-NOT | | 0|FAIL-NOT | | 0|
SUCC-TRAN | 0| 0|FAIL-TRAN | 0| 0|
NOCHAN-CALL| 0| 0|NOCHAN-REG | 0| 0|
NOCHAN-SUB | 0| |NOCHAN-NOT | | 0|
EXP-RETRY | 0| 0|DTMF | 0| 0|
HOLD | 0| 0|UN-HOLD | 0| 0|
UNKNOWN | 0| 1228|REINVITES | 0| 0|
LOST-NOBUF | 0| 0|OUTSEQ | 0| |
DENIED-IP | 0| |BANNED-IP | 0| |
------------------------------------------------------------------------[12:34:34] ABILIS_CPX:d se ctisip
RES:CtiSip --------------------------------------------------------------------
Session_Initiation_Protocol
--- Cleared 0 days 19:38:44 ago, on 28/05/2015 at 19:48:20 -------------
-----------|---INPUT---|--OUTPUT---|-----------|---INPUT---|--OUTPUT---|
SUCC-CALL | 0| 0|FAIL-CALL | 0| 0|
SUCC-REG | 0| 1843|FAIL-REG | 0| 0|
SUCC-SUB | 0| |FAIL-SUB | 0| |
SUCC-NOT | | 0|FAIL-NOT | | 0|
SUCC-TRAN | 0| 0|FAIL-TRAN | 0| 0|
NOCHAN-CALL| 0| 0|NOCHAN-REG | 0| 0|
NOCHAN-SUB | 0| |NOCHAN-NOT | | 0|
EXP-RETRY | 0| 0|DTMF | 0| 0|
HOLD | 0| 0|UN-HOLD | 0| 0|
UNKNOWN | 0| 1228|REINVITES | 0| 0|
LOST-NOBUF | 0| 0|OUTSEQ | 0| |
DENIED-IP | 0| |BANNED-IP | 0| |
------------------------------------------------------------------------
CH:0 CallId:
CG: CD:
-----------|---INPUT---|--OUTPUT---|-----------|---INPUT---|--OUTPUT---|
RTP-PCK | 0| 0|T38-PCK | 0| 0|
RTP-NOBUF | 0| 0|T38-NOBUF | 0| 0|
RTP-LOST | 0| 0|T38-LOST | 0| |
RTP-OUTSEQ | 0| |T38-OUTSEQ | 0| |
RTP-MALFORM| 0| |T38-MALFORM| 0| |
RTCP-PCK | 0| 0|SIP-OUTSEQ | 0| |
------------------------------------------------------------------------
CH:1 CallId:
CG: CD:
-----------|---INPUT---|--OUTPUT---|-----------|---INPUT---|--OUTPUT---|
RTP-PCK | 0| 0|T38-PCK | 0| 0|
RTP-NOBUF | 0| 0|T38-NOBUF | 0| 0|
RTP-LOST | 0| 0|T38-LOST | 0| |
RTP-OUTSEQ | 0| |T38-OUTSEQ | 0| |
RTP-MALFORM| 0| |T38-MALFORM| 0| |
RTCP-PCK | 0| 0|SIP-OUTSEQ | 0| |
------------------------------------------------------------------------
CH:2 CallId:
CG: CD:
-----------|---INPUT---|--OUTPUT---|-----------|---INPUT---|--OUTPUT---|
RTP-PCK | 0| 0|T38-PCK | 0| 0|
RTP-NOBUF | 0| 0|T38-NOBUF | 0| 0|
RTP-LOST | 0| 0|T38-LOST | 0| |
RTP-OUTSEQ | 0| |T38-OUTSEQ | 0| |
RTP-MALFORM| 0| |T38-MALFORM| 0| |
RTCP-PCK | 0| 0|SIP-OUTSEQ | 0| |
------------------------------------------------------------------------
CH:3 CallId:
CG: CD:
-----------|---INPUT---|--OUTPUT---|-----------|---INPUT---|--OUTPUT---|
RTP-PCK | 0| 0|T38-PCK | 0| 0|
RTP-NOBUF | 0| 0|T38-NOBUF | 0| 0|
RTP-LOST | 0| 0|T38-LOST | 0| |
RTP-OUTSEQ | 0| |T38-OUTSEQ | 0| |
RTP-MALFORM| 0| |T38-MALFORM| 0| |
RTCP-PCK | 0| 0|SIP-OUTSEQ | 0| |
------------------------------------------------------------------------
CH:4 CallId:
CG: CD:
-----------|---INPUT---|--OUTPUT---|-----------|---INPUT---|--OUTPUT---|
RTP-PCK | 0| 0|T38-PCK | 0| 0|
RTP-NOBUF | 0| 0|T38-NOBUF | 0| 0|
RTP-LOST | 0| 0|T38-LOST | 0| |
RTP-OUTSEQ | 0| |T38-OUTSEQ | 0| |
RTP-MALFORM| 0| |T38-MALFORM| 0| |
RTCP-PCK | 0| 0|SIP-OUTSEQ | 0| |
------------------------------------------------------------------------
CH:5 CallId:
CG: CD:
-----------|---INPUT---|--OUTPUT---|-----------|---INPUT---|--OUTPUT---|
RTP-PCK | 0| 0|T38-PCK | 0| 0|
RTP-NOBUF | 0| 0|T38-NOBUF | 0| 0|
RTP-LOST | 0| 0|T38-LOST | 0| |
RTP-OUTSEQ | 0| |T38-OUTSEQ | 0| |
RTP-MALFORM| 0| |T38-MALFORM| 0| |
RTCP-PCK | 0| 0|SIP-OUTSEQ | 0| |
------------------------------------------------------------------------
CH:6 CallId:
CG: CD:
-----------|---INPUT---|--OUTPUT---|-----------|---INPUT---|--OUTPUT---|
RTP-PCK | 0| 0|T38-PCK | 0| 0|
RTP-NOBUF | 0| 0|T38-NOBUF | 0| 0|
RTP-LOST | 0| 0|T38-LOST | 0| |
RTP-OUTSEQ | 0| |T38-OUTSEQ | 0| |
RTP-MALFORM| 0| |T38-MALFORM| 0| |
RTCP-PCK | 0| 0|SIP-OUTSEQ | 0| |
------------------------------------------------------------------------
CH:7 CallId:
CG: CD:
-----------|---INPUT---|--OUTPUT---|-----------|---INPUT---|--OUTPUT---|
RTP-PCK | 0| 0|T38-PCK | 0| 0|
RTP-NOBUF | 0| 0|T38-NOBUF | 0| 0|
RTP-LOST | 0| 0|T38-LOST | 0| |
RTP-OUTSEQ | 0| |T38-OUTSEQ | 0| |
RTP-MALFORM| 0| |T38-MALFORM| 0| |
RTCP-PCK | 0| 0|SIP-OUTSEQ | 0| |
------------------------------------------------------------------------
CH:8 CallId:
CG: CD:
-----------|---INPUT---|--OUTPUT---|-----------|---INPUT---|--OUTPUT---|
RTP-PCK | 0| 0|T38-PCK | 0| 0|
RTP-NOBUF | 0| 0|T38-NOBUF | 0| 0|
RTP-LOST | 0| 0|T38-LOST | 0| |
RTP-OUTSEQ | 0| |T38-OUTSEQ | 0| |
RTP-MALFORM| 0| |T38-MALFORM| 0| |
RTCP-PCK | 0| 0|SIP-OUTSEQ | 0| |
------------------------------------------------------------------------
CH:9 CallId:
CG: CD:
-----------|---INPUT---|--OUTPUT---|-----------|---INPUT---|--OUTPUT---|
RTP-PCK | 0| 0|T38-PCK | 0| 0|
RTP-NOBUF | 0| 0|T38-NOBUF | 0| 0|
RTP-LOST | 0| 0|T38-LOST | 0| |
RTP-OUTSEQ | 0| |T38-OUTSEQ | 0| |
RTP-MALFORM| 0| |T38-MALFORM| 0| |
RTCP-PCK | 0| 0|SIP-OUTSEQ | 0| |
------------------------------------------------------------------------To show the log of CTISIP type the following command:
[15:54:16] ABILIS_CPX:d ctisip log
CURRENT EVENTS LOG MASK: ERR REG INFO
19/07 15:57:23 [ 10] Reg Info in IN channel with 192.168.20.107:42968
19/07 15:57:23 [ 10] Opened new SIP REG channel
19/07 15:57:23 [ 10] Declared user: test
19/07 15:57:23 [ 10] Freeing the channel
19/07 15:57:28 [ 10] Reg Info in IN channel with 192.168.20.107:63330
19/07 15:57:28 [ 10] Opened new SIP REG channel
19/07 15:57:28 [ 10] Declared user: test3
19/07 15:57:28 [ 10] Freeing the channel
19/07 15:59:34 [ 10] Reg Info in IN channel with 192.168.20.107:42968
19/07 15:59:34 [ 10] Opened new SIP REG channel
19/07 15:59:34 [ 10] Declared user: test
19/07 15:59:34 [ 10] Freeing the channel
19/07 15:59:38 [ 10] Reg Info in IN channel with 192.168.20.107:63330
19/07 15:59:38 [ 10] Opened new SIP REG channel
19/07 15:59:38 [ 10] Declared user: test3
19/07 15:59:38 [ 10] Freeing the channel
19/07 16:00:15 [ 10] Reg Info in IN channel with 192.168.20.107:42968
19/07 16:00:15 [ 10] Opened new SIP REG channel
19/07 16:00:15 [ 10] Declared user: test
19/07 16:00:15 [ 10] Freeing the channel
19/07 16:00:16 [ 10] Reg Info in IN channel with 192.168.20.107:63330
19/07 16:00:16 [ 10] Opened new SIP REG channel
19/07 16:00:16 [ 10] Declared user: test3
19/07 16:00:16 [ 10] Freeing the channel
To set the filter event use, type the command: s ctisip log event:<filter>
[15:55:22] ABILIS_CPX:s ctisip log event: ?S CTISIP LOG EVENT:val Set CTISIP log events filter EVENT: CTISIP log events filter [ERR, REG, INFO] or [DFT, FULL], where: - ERR, REG, INFO filters can be joined using "," operator; - DFT: means ERR events; - FULL: means every type of event. [15:55:46] ABILIS_CPX:s ctisip log event:fullDebug log mask was set to:ERR REG INFO
To clear the log, type the following command:
[15:55:25] ABILIS_CPX:c ctisip log
Now session log is emptyBelow debug commands are described.
![[Note]](../images/note.png) | Note |
|---|---|
To use these commands you need to have administrator or super user rights. |
Type the following command to display the syntax of the command:
[12:34:34] ABILIS_CPX:debug res:ctisip lsn:0
RES:CtiSip --------------------------------------------------------------------
Session_Initiation_Protocol
BufferLength:64512 Date/Time:29/05/2015 15:22:27 TraceTime:70443851
Usage:
LSN:0 - This help
LSN:1 - Extra channels diags
LSN:2 - Advanced channels diags
LSN:3 - Show debug log
LSN:3 CMD:CLR - Clear debug log
LSN:3 CMD:SET:[DFT | CLR | FULL | [level,...]] - Set log event mask
No parameters - Show current events log mask
DFT - Log default events (ERR events only)
CLR - Clear log event mask
FULL - Log all events
levels:
ERR - Log only error events
REG - Registration events
INFO - Informative events
LSN:4 - Show registrations
LSN:4 CMD:<user> - Show registration of the specified user
LSN:5 - Show subscriptions
LSN:5 CMD:<user> - Show subscriptions of the specified user
LSN:10 CMD:<user> - Make remote registration with the specified user
LSN:11 CMD:<user> - De-register the specified user
LSN:12 CMD:<user> - Remove subscriptions of the specified user
LSN:20 CMD:<NumPackets> - Simulates loss of NumPackets packets from CTIR
LSN:21 CMD:<NumPackets> - Simulates loss of NumPackets packets to CTIR
LSN:22 - Print Call&Ring table
LSN:23 - Print Capability table
LSN:24 CMD:<user> - Remove a specified user from capability table
LSN:24 CMD:ALL - Remove all users from capability table
LSN:30 - Show extra UDP receivers dignosticsType the below command to view the event logs connected with the users registration:
[12:37:17] ABILIS_CPX:debug res:ctisip lsn:3
RES:CtiSip --------------------------------------------------------------------
Session_Initiation_Protocol
BufferLength:64512 Date/Time:29/05/2015 15:23:20 TraceTime:70496487
DD/MM/YYYY HH:MM:SS - CHANNEL DESCRIPTION
29/05/2015 09:33:26 - [ 30] Error in OUT channel with 62.62.62.62:5060
29/05/2015 09:33:26 - [ 30] AUTH timer timeout
29/05/2015 11:08:09 - [ 30] Error in OUT channel with 62.62.62.62:5060
29/05/2015 11:08:09 - [ 30] AUTH timer timeout
29/05/2015 15:34:56 - [ 30] Error in OUT channel with 62.62.62.62:5060
29/05/2015 15:34:56 - [ 30] AUTH timer timeout
29/05/2015 15:40:44 - [ 30] Error in OUT channel with 62.62.62.62:5060
29/05/2015 15:40:44 - [ 30] AUTH timer timeout
29/05/2015 17:46:24 - [ 30] Error in OUT channel with 62.62.62.62:5060
29/05/2015 17:46:24 - [ 30] AUTH timer timeoutThis table shows data, time, identification of the event and the description of the error.
Possible errors could be:
Unknown user;
Codec not supported;
Retransmission out of time (happens when you're cut off).
The most common usage is:
debug res:ctisip lsn:3: shows log;
debug res:ctisip lsn:3 cmd:clr: clear log;
debug res:ctisip lsn:3 cmd:set:err: set log mask to log only errors events;
debug res:ctisip lsn:3 cmd:set:err,reg: set log mask to log only errors and registration events;
debug res:ctisip lsn:3 cmd:set:full: set log mask to log any event.
The following command allows to show the registration table (remote peers registered with Abilis and remote peers Abilis is registered too).
[17:03:12] ABILIS_CPX:debug res:ctisip lsn:4
RES:CtiSip --------------------------------------------------------------------
Session_Initiation_Protocol
BufferLength:64512 Date/Time:29/05/2015 15:24:37 TraceTime:70573545
User Host Prot Port REG LIFETIME AGE
-------------------------------------------------------------------------------
sip_proxy 062.062.062.062 UDP 5060 REMOTE 120 21
zoiper 192.168.000.024 UDP 5060 LOCAL 60 35
-------------------------------------------------------------------------------Meaning of the parameters:
UserUsername registered in the user table (d user).
HostIP address of the user.
ProtTransport protocol.
PortUDP port of the user.
REGRegistration of the user [REMOTE: Abilis
is registered to a remote peer; LOCAL: a remote
peer is registered to Abilis].
LIFETIMEHow often (in seconds) the registration is requested.
AGETime (in seconds) since last valid registration.
In the previous example, Abilis is registered to the remote peer
sip_proxy (IP address: 62.62.62.62) which needs
Abilis registration each 120 seconds; Abilis registered itself 21
seconds ago.
The user zoiper (IP address: 192.168.0.24) is
registered to Abilis; it registered itself 35 seconds ago.
![[Tip]](../images/tip.png) | Tip |
|---|---|
Interesting chapter: Section 71.29.1, “How to trace only the SIP signaling traffic”. |
| |  | |
| 50.6. Busy Lamp Field (BLF) |  | 50.8. Appendix - SIP protocol overview |