Skip to end of metadata
Go to start of metadata

You are viewing an old version of this page. View the current version.

Compare with Current View Page History

Version 1 Next »

IMG 1010 - Call Trace - SIP to SS7

Below is a call trace which displays SIP to SS7 call. 

See IMG 1010 - RADIUS - CDR Example - SIP to SS7 for the associated RADIUS CDR.

Trying 192.168.19.52...
Connected to img (192.168.19.52).
Escape character is '^]'.
username: excel
Password:
 *** NOT Clearing GEL Print Buffer ***
>
# Entering the SS7 menu
> 3
L3> s
# Enabling SS7 ISUP trace
ss7> a0
ISUP/TUP SU Diagnostics Enabled for stack 0
# Exiting to main menu
ss7> q
L3> q
# Entering the SIP menu
> S
# Enabling the SIP trace
SIP> 1
 SIP PDU Printing Enabled
# Exiting to main menu
SIP> q
# Entering the call trace menu
> W
GEL> 29
# Enabling call tracing
CALL> P
-- Logging & Printing All Events --
15:47:39.959 SIP (W)  
      ---> [10.129.51.140, 1053]
     INVITE sip:5088625347@10.129.51.152:5060 SIP/2.0
     Via: SIP/2.0/UDP 10.129.51.140
     To: 5088625347<sip:5088625347@10.129.51.152:5060>
     From: 6175551212<sip:6175551212@10.129.51.140:5060>;tag=117938002f7f75
     Call-ID: CSP20001.49b.3112821.830@10.129.51.140
     Contact: 6175551212<sip:6175551212@10.129.51.140:5060>
     User-Agent: Excel_CSP/82.30.189
     Supported: timer
     Session-Expires: 1800
     Min-SE: 300
     CSeq: 1 INVITE
     Content-Type: application/sdp
     Content-Length: 105
     v=0
     o=sip 0 0 IN IP4 10.129.51.140
     s=SIP_Call
     c=IN IP4 10.129.51.144
     t=0 0
     m=audio 12716 RTP/AVP 0
      
15:47:39.959 SIP (W)  
      <--- [10.129.51.140, 5060 <- 10.129.51.152, 5060]
     SIP/2.0 100 Trying
     Via: SIP/2.0/UDP 10.129.51.140;received=10.129.51.140
     Call-ID: CSP20001.49b.3112821.830@10.129.51.140
     From: 6175551212<sip:6175551212@10.129.51.140:5060>;tag=
     117938002f7f75
     To: 5088625347<sip:5088625347@10.129.51.152:5060>
     CSeq: 1 INVITE
     Server: Cantata-SIP/10.3.2.105 E1_System 1
     Content-Length: 0
      
      
15:47:39.959 CALL(SIP) (01:0001:00) RCVD INVITE from 10.129.51.140:0 UDP
15:47:39.959 CALL(SIP) (01:0001:00)      with Via sent-by: 10.129.51.140
15:47:39.959 CALL(SIP) (01:0001:00) SENT 100 Trying to 10.129.51.140:0
15:47:39.959 CALL(SIP) (01:0001:00) SENT Route Ctrl to L4
15:47:39.959 CALL(L4)  (01:0001:00) RCVD Route Control from SIP
15:47:39.959 CALL(L4)  (01:0001:00) Accessing Route Table 2
15:47:39.959 CALL(L4)  (01:0001:00) Accessing Resource Table 1
15:47:39.959 CALL(L4)  (01:0001:00) IP Traffic Management: Resource Group ID: 2
                       568 Busy Count: 1  Channels Allowed: 1024
15:47:39.959 CALL(L4)  (01:0001:00) SENT Route Control Ack to SIP
15:47:39.959 CALL(SIP) (01:0001:00) RCVD Route Ctrl Ack from L4
15:47:39.959 CALL(SIP) (01:0001:00) Session Group Profile ID is 0
15:47:39.959 CALL(SIP) (01:0001:00) SENT Route Ctrl to L4
15:47:39.959 CALL(L4)  (01:0001:00) RCVD Route Control from SIP
15:47:39.959 CALL(L4)  (01:0001:00) Accessing IP Bearer Profiles
15:47:39.959 CALL(L4)  (01:0001:00) Profile Id 1 (RG 769)
15:47:39.959 CALL(L4)  (01:0001:00) SENT Route Control Ack to SIP
15:47:39.959 CALL(SIP) (01:0001:00) RCVD Route Ctrl Ack from L4
15:47:39.959 CALL(SIP) (01:0001:00) m line codec list:  0
15:47:39.959 CALL(SIP) (01:0001:00) Leg 0 associated with hndl(19999), LTS(1792)
15:47:39.959 CALL(SIP) (01:0001:00) SENT Setup to L4
15:47:39.959 CALL(L4)  (01:0001:00) RCVD Setup Ind  from SIP
15:47:39.959 CALL(L4)  (01:0001:00) SENT RFS to GCL
15:47:39.969 CALL(GCL) (01:0001:00) RCVD RFS DN=[5088625347] ANI=[6175551212] from L4
15:47:39.969 CALL(GCL) (01:0001:00) ANI APRI=[0],SI=[0],Category=[10]
15:47:39.969 CALL(GCL) (01:0001:00) Incoming Channel Group = 4 [SIP_CSP]
15:47:39.969 CALL(GCL) (01:0001:00) DPE Input :DN=[5088625347] ANI=[6175551212]
15:47:39.969 CALL(GCL) (01:0001:00) Invoke Incoming DPE 1; Channel Group 4
15:47:39.969 CALL(GCL) (01:0001:00) DPE response: Proc Complete
15:47:39.969 CALL(GCL) (01:0001:00) DPE Output:DN=[5088625347] ANI=[6175551212]
15:47:39.969 CALL(GCL) (01:0001:00) SENT RADIUS ACCT START
15:47:39.969 CALL(L4)  (01:0001:00) RCVD RFS response  from GCL
15:47:39.969 CALL(GCL) (01:0001:00) RCVD RADIUS ACCT START ACK
15:47:39.969 CALL(GCL) (01:0001:01) SENT Route Control to L4
15:47:39.969 CALL(L4)  (01:0001:00) RCVD Route Control from GCL
15:47:39.969 CALL(L4)  (01:0001:00) Accessing Route Table 5
15:47:39.969 CALL(L4)  (01:0001:00) Accessing Route Table 5
15:47:39.969 CALL(GCL) (01:0001:01) RCVD Mid Stream Router Response
15:47:39.969 CALL(GCL) (01:0001:01) Outgoing Channel Group = 8 [SS7_E1_CSP]
15:47:39.969 CALL(GCL) (01:0001:01) SENT Route Control to L4
15:47:39.969 CALL(L4)  (01:0001:01) RCVD Route Control from GCL
15:47:39.969 CALL(L4)  (01:0001:01) Accessing Resource Table 1
15:47:39.969 CALL(L4)  (01:0001:01) Resource Group ID is 40
15:47:39.969 CALL(L4)  (01:0001:01) SENT Outseize Ctrl to SS7
15:47:39.969 CALL(GCL) (01:0001:01) RCVD CPE of ADDRESS INFO from L4
15:47:39.969 CALL(GCL) (01:0001:01) Leg 1 associated with LTS(386)
15:47:39.969 CALL(SS7) (01:0001:01) RCVD Outseize Ctrl from L4 (0x813:0x382b:0)
15:47:39.969 SS7 (U)   XMT 1: sls:00 pri:00 (0000382b,0000) IAM   [0020000a0002
     0907031005882635740a070310165755212100]
15:47:39.969 CALL(SS7) (01:0001:01) SENT IAM (0x813:0x382b:0)
15:47:40.229 SS7 (U)   RCV 1: sls:00 pri:00 (0000382b,0000) ACM   [000400]
15:47:40.229 CALL(SS7) (01:0001:01) RCVD ACM (0x382b:0x813:0)
15:47:40.229 CALL(SS7) (01:0001:01) SENT Cut Thru to L4 (0x382b:0x813:0)
15:47:40.229 CALL(SS7) (01:0001:01) SENT Outseize ACK to L4 (0x382b:0x813:0)
15:47:40.229 CALL(L4)  (01:0001:01) RCVD Cut Thru  from SS7
15:47:40.239 CALL(L4)  (01:0001:01) RCVD Outseize ACK  from SS7
15:47:40.239 CALL(GCL) (01:0001:00) SENT Connect Tone to L4
15:47:40.239 CALL(L4)  (01:0001:00) RCVD Connect Tone from GCL
15:47:40.239 CALL(L4)  (01:0001:00) SENT Request DSP Service to SYSRM
15:47:40.239 CALL(MED) (01:0001:00) Transmitting tone 0x2 on (0x1,0x1,0x0)
15:47:40.239 CALL(MED) (01:0001:00) RCVD OUTPULSE CP
15:47:40.239 CALL(GCL) (01:0001:00) SENT Connect w/Pad Response to L4
15:47:40.239 CALL(L4)  (01:0001:00) SENT Progress to SIP
15:47:40.239 CALL(SIP) (01:0001:00) RCVD Progress from L4
15:47:40.239 CALL(SIP) (01:0001:00) Set Fax Type to Relay T.38
15:47:40.239 CALL(SIP) (01:0001:00) SENT L3-L3 Outseize Ctrl to VPPL
15:47:40.239 CALL(IP)  (01:0001:00) RCVD Outseize from L3, [vts 768] [m1.0.0]
15:47:40.239 CALL(IP)  (01:0001:00) RTP: (Src) 10.129.51.134:8000
15:47:40.239 CALL(IP)  (01:0001:00) RTP: (Dst) 10.129.51.144:12716
15:47:40.249 CALL(IP)  (01:0001:00) VoIP Codec is G711Mulaw; Payload Size is 20ms
15:47:40.259 CALL(IP)  (01:0001:00) SENT Outseize ACK to L3P, toPvid: x66
15:47:40.259 CALL(SIP) (01:0001:00) RCVD Outseize Ack from VPPL
15:47:40.259 CALL(SIP) (01:0001:00) SENT 183 Session Progress to 10.129.51.140:5060 UDP
15:47:40.259 SIP (W)  
      <--- [10.129.51.140, 5060 <- 10.129.51.152, 5060]
     SIP/2.0 183 Session Progress
     Via: SIP/2.0/UDP 10.129.51.140;received=10.129.51.140
     Contact: <sip:10.129.51.152:5060>
     Call-ID: CSP20001.49b.3112821.830@10.129.51.140
     From: 6175551212<sip:6175551212@10.129.51.140:5060>;tag=
     117938002f7f75
     To: 5088625347<sip:5088625347@10.129.51.152:5060>;tag=a9
     4c095b773be1dd6e8d668a785a9c843102
     CSeq: 1 INVITE
     Server: Cantata-SIP/10.3.2.105 E1_System 1
     Content-Type: application/sdp
     Content-Length: 176
      
     v=0
     o=Cantata_SDP 0 0 IN IP4 10.129.51.152
     s=Cantata-SIP
     c=IN IP4 10.129.51.134
     t=0 0
     m=audio 8000 RTP/AVP 0
     a=rtpmap:0 PCMU/8000
     a=silenceSupp:off - - - -
     a=ptime:20
      
      
15:47:40.259 CALL(SIP) (01:0001:00) RCVD Cut Thru from VPPL
15:47:40.259 CALL(SIP) (01:0001:00) RCVD Connect from VPPL
15:47:43.869 SS7 (U)   RCV 1: sls:00 pri:00 (0000382b,0000) ANM   [00]
15:47:43.869 CALL(SS7) (01:0001:01) RCVD ANM (0x382b:0x813:0)
15:47:43.869 CALL(SS7) (01:0001:01) SENT Connect to L4 (0x382b:0x813:0)
15:47:43.869 CALL(L4)  (01:0001:01) RCVD Connect  from SS7
15:47:43.869 CALL(L4)  (01:0001:01) SENT CPE of ANSWER  to GCL
15:47:43.869 CALL(GCL) (01:0001:01) RCVD CPE of ANSWER  from L4
15:47:43.869 CALL(GCL) (01:0001:01) SENT RADIUS ACCT START
15:47:43.869 CALL(GCL) (01:0001:01) RCVD RADIUS ACCT START ACK
15:47:43.869 CALL(GCL) (01:0001:00) SENT Disconnect Tone to L4
15:47:43.869 CALL(L4)  (01:0001:00) RCVD Disconnect Tone from GCL
15:47:43.869 CALL(L4)  (01:0001:00) SENT Cancel DSP Service to SYSRM
15:47:43.869 CALL(MED) (01:0001:00) RCVD CANCEL OUTPULSE CP
15:47:43.869 CALL(MED) (01:0001:00) RCVD CANCEL OUTPULSE DIGITS
15:47:43.869 CALL(GCL) (01:0001:00) SENT CPE of ANSWER  to L4
15:47:43.869 CALL(L4)  (01:0001:00) RCVD CPE of ANSWER from GCL
15:47:43.869 CALL(L4)  (01:0001:00) SENT Connect to SIP
15:47:43.869 CALL(SIP) (01:0001:00) RCVD Connect from L4
15:47:43.869 CALL(SIP) (01:0001:00) SENT 200 OK to 10.129.51.140:5060 UDP
15:47:43.869 SIP (W)  
      <--- [10.129.51.140, 5060 <- 10.129.51.152, 5060]
     SIP/2.0 200 OK
     Via: SIP/2.0/UDP 10.129.51.140;received=10.129.51.140
     Contact: <sip:10.129.51.152:5060>
     Call-ID: CSP20001.49b.3112821.830@10.129.51.140
     From: 6175551212<sip:6175551212@10.129.51.140:5060>;tag=
     117938002f7f75
     To: 5088625347<sip:5088625347@10.129.51.152:5060>;tag=a9
     4c095b773be1dd6e8d668a785a9c843102
     CSeq: 1 INVITE
     Server: Cantata-SIP/10.3.2.105 E1_System 1
     Allow: INVITE, BYE, REGISTER, ACK, OPTIONS, CANCEL, INFO
      
     Supported: path
     Accept: application/sdp
     Content-Type: application/sdp
     Content-Length: 176
      
     v=0
     o=Cantata_SDP 0 1 IN IP4 10.129.51.152
     s=Cantata-SIP
     c=IN IP4 10.129.51.134
     t=0 0
     m=audio 8000 RTP/AVP 0
     a=rtpmap:0 PCMU/8000
     a=silenceSupp:off - - - -
     a=ptime:20
15:47:43.899 SIP (W)  
      ---> [10.129.51.140, 1053]
     ACK sip:10.129.51.152:5060 SIP/2.0
     Via: SIP/2.0/UDP 10.129.51.140
     To: 5088625347<sip:5088625347@10.129.51.152:5060>;tag=a9
     4c095b773be1dd6e8d668a785a9c843102
     From: 6175551212<sip:6175551212@10.129.51.140:5060>;tag=
     117938002f7f75
     Call-ID: CSP20001.49b.3112821.830@10.129.51.140
     CSeq: 1 ACK
     Content-Length: 0
           
15:47:43.899 CALL(SIP) (01:0001:00) RCVD ACK from 10.129.51.140 UDP
15:47:43.899 CALL(SIP) (01:0001:00)      with Via sent-by: 10.129.51.140
15:48:05.019 SIP (W)  
      ---> [10.129.51.140, 1053]
     BYE sip:10.129.51.152:5060 SIP/2.0
     Via: SIP/2.0/UDP 10.129.51.140
     To: 5088625347<sip:5088625347@10.129.51.152:5060>;tag=a9
     4c095b773be1dd6e8d668a785a9c843102
     From: 6175551212<sip:6175551212@10.129.51.140:5060>;tag=
     117938002f7f75
     Call-ID: CSP20001.49b.3112821.830@10.129.51.140
     CSeq: 2 BYE
     User-Agent: Excel_CSP/82.30.189
     Content-Length: 0
      
15:48:05.019 CALL(SIP) (01:0001:00) RCVD BYE from 10.129.51.140:0 UDP
15:48:05.019 CALL(SIP) (01:0001:00)      with Via sent-by: 10.129.51.140 UDP
15:48:05.019 CALL(SIP) (01:0001:00) SENT L3-L3 Clear Req to VPPL
15:48:05.019 CALL(IP)  (01:0001:00) RCVD Clear Request from L3
15:48:05.019 CALL(IP)  (01:0001:00) RTCP STATS: TxPackets=1237; RxPackets=1236;
                       lostPackets=0
15:48:05.019 CALL(IP)  (01:0001:00) RTCP/T38 Packet STATS: TxPackets=1237; RxPa
                       ckets=1236; lostPackets=0
15:48:05.019 CALL(SIP) (01:0001:00) RCVD Clear Req from VPPL
15:48:05.019 CALL(SIP) (01:0001:00) SENT Clear Request to L4
15:48:05.019 CALL(SIP) (01:0001:00) SENT 200 OK to 10.129.51.140:5060 UDP
15:48:05.019 SIP (W)  
      <--- [10.129.51.140, 5060 <- 10.129.51.152, 5060]
     SIP/2.0 200 OK
     Via: SIP/2.0/UDP 10.129.51.140;received=10.129.51.140
     Contact: <sip:10.129.51.152:5060>
     Call-ID: CSP20001.49b.3112821.830@10.129.51.140
     From: 6175551212<sip:6175551212@10.129.51.140:5060>;tag=
     117938002f7f75
     To: 5088625347<sip:5088625347@10.129.51.152:5060>;tag=a9
     4c095b773be1dd6e8d668a785a9c843102
     CSeq: 2 BYE
     Server: Cantata-SIP/10.3.2.105 E1_System 1
     Content-Length: 0
      
15:48:05.019 CALL(L4)  (01:0001:00) RCVD Clear request  from SIP
15:48:05.019 CALL(L4)  (01:0001:00) SENT Channel Release w/data to GCL
15:48:05.019 CALL(GCL) (01:0001:00) RCVD Channel Released w/data from L4
15:48:05.019 CALL(GCL) (01:0001:00) Call Duration(sec): 22
15:48:05.019 CALL(GCL) (01:0001:01) SENT Clear Response to L4
15:48:05.019 CALL(GCL) (01:0001:00) Radius Call Duration(sec): 22
15:48:05.019 CALL(GCL) (01:0001:00) SENT RADIUS ACCT STOP
15:48:05.019 CALL(L4)  (01:0001:01) RCVD Clear  from GCL
15:48:05.019 CALL(L4)  (01:0001:01) SENT Clear Request to SS7
15:48:05.019 CALL(SS7) (01:0001:01) RCVD Clear Request from L4 (0x813:0x382b:0)
15:48:05.019 SS7 (U)   XMT 1: sls:00 pri:00 (0000382b,0000) REL   [0200028090]
15:48:05.019 CALL(SS7) (01:0001:01) SENT REL (0x813:0x382b:0) cause 16
15:48:05.089 SS7 (U)   RCV 1: sls:00 pri:00 (0000382b,0000) RLC   [00]
15:48:05.089 CALL(SS7) (01:0001:01) RCVD RLC (0x382b:0x813:0)
15:48:05.089 CALL(SS7) (01:0001:01) SENT Clear Request to L4 (0x382b:0x813:0)
15:48:05.089 CALL(L4)  (01:0001:01) RCVD Clear request  from SS7
15:48:05.089 CALL(L4)  (01:0001:01) SENT Channel Release w/data to GCL
15:48:05.089 CALL(GCL) (01:0001:01) RCVD Channel Released w/data from L4
15:48:05.089 CALL(GCL) (01:0001:01) Call Duration(sec): 22
15:48:05.089 CALL(GCL) (01:0001:01) Radius Call Duration(sec): 22
15:48:05.089 CALL(GCL) (01:0001:01) SENT RADIUS ACCT STOP
  • No labels