Call Trace - Spirou SIP to SS7

 

For SIP to SS7, below is Call Trace displaying the received SIP INFO message and the interworked SS7 ITX message with the C2/C3 parameters. Relevant sections are identified.

18:54:41.962 CALL(SIP) (00:00013:00) RCVD INVITE W/SDP from 10.129.47.12:5060 udp CSeq:1 18:54:41.962 CALL(SIP) (00:00013:00) with Via sent-by: 10.129.47.12 18:54:41.962 CALL(SIP) (00:00013:00) Call-id: 1-2032@10.129.47.12 18:54:41.962 CALL(SIP) (00:00013:00) and Msg Size: 641 18:54:41.962 CALL(SIP) (00:00013:00) ---> [10.129.47.12, 5060] INVITE sip:3387@10.129.47.15:5060 SIP/2.0\r\n Via: SIP/2.0/UDP 10.129.47.12:5060\r\n From: sipp <sip:8888@10.129.47.12:5060>;tag=1\r\n To: sut <sip:3387@10.129.47.15:5060>\r\n Call-ID: 1-2032@10.129.47.12\r\n Cseq: 1 INVITE\r\n Contact: sip:8888@10.129.47.12:5060\r\n Max-Forwards: 70\r\n Subject: Performance Test\r\n Content-Type: application/sdp\r\n Content-Length: 269\r\n Accept: application/sdp\r\n \r\n v=0\r\n o=CiscoSystemsSIP-IPPhone-UserAgent 15616 4992 IN IP4 10 .129.47.12\r\n s=SIP Call\r\n c=IN IP4 10.129.47.12\r\n t=0 0\r\n m=audio 10000 RTP/AVP 18 0 8 110\r\n a=rtpmap:18 G729a/8000\r\n a=rtpmap:8 PCMA/8000\r\n a=rtpmap:0 PCMU/8000\r\n a=rtpmap:110 telephone-event/8000\r\n a=fmtp:110 0-15\r\n 18:54:41.962 CALL(SIP) (00:00013:00) SENT 100 Trying to 10.129.47.12:5060 18:54:41.962 CALL(SIP) (00:00013:00) <--- [10.129.47.12, 5060 <- 10.129.47.15, 5060] SIP/2.0 100 Trying\r\n Via: SIP/2.0/UDP 10.129.47.12:5060;received=10.129.47.12 \r\n Call-ID: 1-2032@10.129.47.12\r\n From: sipp <sip:8888@10.129.47.12:5060>;tag=1\r\n To: sut <sip:3387@10.129.47.15:5060>\r\n CSeq: 1 INVITE\r\n Server: Dialogic-SIP/10.5.3.110 1010_Primary 0\r\n Content-Length: 0\r\n \r\n 18:54:41.962 CALL(SIP) (00:00013:00) SENT Route Control to L4 18:54:41.962 CALL(L4) (00:00013:00) RCVD Route Control from SIP 18:54:41.962 CALL(L4) (00:00013:00) Accessing Route Table 2 18:54:41.962 CALL(L4) (00:00013:00) Accessing Resource Table 1 18:54:41.962 CALL(L4) (00:00013:00) Hunting Algorithm is Round Robin 18:54:41.962 CALL(L4) (00:00013:00) SENT Route Control Ack to SIP 18:54:41.962 CALL(SIP) (00:00013:00) RCVD Route Control Ack from L4 18:54:41.962 CALL(SIP) (00:00013:00) Session Group Profile ID is 1 18:54:41.962 CALL(SIP) (00:00013:00) SENT Route Control to L4 18:54:41.962 CALL(L4) (00:00013:00) RCVD Route Control from SIP 18:54:41.962 CALL(L4) (00:00013:00) Accessing IP Bearer Profiles 18:54:41.962 CALL(L4) (00:00013:00) Profile Id 1 (RG 769) 18:54:41.962 CALL(L4) (00:00013:00) SENT Route Control Ack to SIP 18:54:41.962 CALL(SIP) (00:00013:00) RCVD Route Control Ack from L4 18:54:41.962 CALL(SIP) (00:00013:00) m line (audio) codec list: 18 0 8 110 18:54:41.962 CALL(SIP) (00:00013:00) RTP Type: 18, name: G729A, clk: 8000 18:54:41.962 CALL(SIP) (00:00013:00) RTP Type: 8, name: PCMA, clk: 8000 18:54:41.962 CALL(SIP) (00:00013:00) RTP Type: 0, name: PCMU, clk: 8000 18:54:41.962 CALL(SIP) (00:00013:00) RTP Type: 110, name: telephone-event, clk: 8000 18:54:41.962 CALL(SIP) (00:00013:00) CODEC Negotiation Priority LOCAL 18:54:41.962 CALL(SIP) (00:00013:00) CPC (Default) 18:54:41.962 CALL(SIP) (00:00013:00) Leg 0 associated with hndl(4987), LTS(1036 )(span 4096 chan 12) 18:54:41.962 CALL(SIP) (00:00013:00) SENT Setup to L4 18:54:41.972 CALL(L4) (00:00013:00) RCVD Setup Ind from SIP 18:54:41.972 CALL(L4) (00:00013:00) SENT RFS to GCL 18:54:41.972 CALL(GCL) (00:00013:00) RCVD RFS DN=[3387] ANI=[8888] from L4 18:54:41.972 CALL(GCL) (00:00013:00) ANI APRI=[0],SI=[0],Category=[10] 18:54:41.972 CALL(GCL) (00:00013:00) DN NOA=[3] 18:54:41.972 CALL(GCL) (00:00013:00) Incoming Channel Group = 1 [IMG_SIP] 18:54:41.972 CALL(GCL) (00:00013:00) SENT Make Call Request to GCL 18:54:41.972 CALL(GCL) (00:00013:01) SENT Route Control to L4 18:54:41.972 CALL(L4) (00:00013:00) RCVD RFS response from GCL 18:54:41.972 CALL(L4) (00:00013:00) RCVD Route Control from GCL 18:54:41.972 CALL(L4) (00:00013:00) Accessing Route Table 5 18:54:41.972 CALL(L4) (00:00013:00) Accessing Route Table 5 18:54:41.972 CALL(GCL) (00:00013:01) RCVD Route Control Ack (Mid Stream Router) from L4 18:54:41.972 CALL(GCL) (00:00013:01) Outgoing Channel Group = 0 [SS7_Out] 18:54:41.972 CALL(GCL) (00:00013:01) SENT Route Control to L4 18:54:41.972 CALL(L4) (00:00013:01) RCVD Route Control from GCL 18:54:41.972 CALL(L4) (00:00013:01) Accessing Resource Table 1 18:54:41.972 CALL(L4) (00:00013:01) Resource Group ID is 32 18:54:41.972 CALL(L4) (00:00013:01) Hunting Algorithm is ROUND_ROBIN_CLOCKWISE 18:54:41.972 CALL(L4) (00:00013:01) IW: Override TMR (03) 18:54:41.972 CALL(L4) (00:00013:01) IW: Override BC/USI 18:54:41.972 CALL(L4) (00:00013:01) RCVD Ported Number 18:54:41.972 CALL(L4) (00:00013:01) SENT Outseize Ctrl to SS7 18:54:41.972 CALL(GCL) (00:00013:01) RCVD CPE of ADDRESS INFO from L4 18:54:41.972 CALL(GCL) (00:00013:01) Leg 1 associated with LTS(78)(span 29 chan 14) 18:54:41.972 CALL(SS7) (00:00013:01) RCVD Outseize Ctrl (0x809:0x1012:12) from L4 18:54:41.972 CALL(SS7) (00:00013:01) SENT: STK: 0 PRI: 00 DPC: 2-2-2 OPC: 1-1-1 SLS: 0x0c CIC: 00012 (0x000c) IAM [0048000a03020604031033780a040310888800] 18:54:41.972 CALL(SS7) (00:00013:01) SENT IAM to (0x809:0x1012:12) 18:54:42.032 CALL(SS7) (00:00013:01) RCVD: STK: 0 PRI: 00 DPC: 1-1-1 OPC: 2-2-2 SLS: 0x00 CIC: 00012 (0x000c) ACM [00000129000000] 18:54:42.032 CALL(SS7) (00:00013:01) RCVD ACM from (0x1012:0x809:12) 18:54:42.032 CALL(SS7) (00:00013:01) SENT Cut Thru (0x1012:0x809:12) to L4 18:54:42.032 CALL(SS7) (00:00013:01) SENT Outseize ACK (0x1012:0x809:12) to L4 18:54:42.032 CALL(L4) (00:00013:01) RCVD Cut Thru from SS7 18:54:42.032 CALL(L4) (00:00013:01) RCVD Outseize ACK from SS7 18:54:42.032 CALL(GCL) (00:00013:00) SENT Connect w/Pad Response to L4 18:54:42.032 CALL(L4) (00:00013:01) SENT CutThru to L4 18:54:42.032 CALL(L4) (00:00000:00) IW: ACM --> 18x procedure by default 18:54:42.032 CALL(L4) (00:00000:00) IW: RFC3398 ACM->18x condition [00] 18:54:42.032 CALL(L4) (00:00013:00) SENT Progress to SIP 18:54:42.032 CALL(L4) (00:00013:00) SENT connect_1way: r_ts=0x4e l_ts=0x40c to TSI 18:54:42.032 CALL(L4) (00:00013:01) SENT connect_1way: r_ts=0x40c l_ts=0x4e to TSI 18:54:42.032 CALL(SS7) (00:00013:01) RCVD Host Connect from (0x809:0x1012:12) f rom L4 18:54:42.032 CALL(SIP) (00:00013:00) RCVD Progress from L4 18:54:42.032 CALL(SIP) (00:00013:00) Set media src IP 10.129.47.16:8048 18:54:42.032 CALL(SIP) (00:00013:00) Set media dst IP 10.129.47.12:10000 18:54:42.032 CALL(SIP) (00:00013:00) CODEC Negotiation Priority LOCAL 18:54:42.032 CALL(SIP) (00:00013:00) Set media PLD ID 2 18:54:42.032 CALL(SIP) (00:00013:00) Set media PLD Size 20, Multiplier:4 18:54:42.032 CALL(SIP) (00:00013:00) RFC 2833 DTMF Relay Enabled, pld type 110 18:54:42.032 CALL(SIP) (00:00013:00) Set Fax Type to Bypass 18:54:42.032 CALL(SIP) (00:00013:00) Source Port Validation : Enabled 18:54:42.032 CALL(SIP) (00:00013:00) SENT L3-L3 Outseize Ctrl to VPPL 18:54:42.032 CALL(IP) (00:00013:00) RCVD Outseize ([vts 12] [m0.0.3]) from L3P (span 4096 chan 12) 18:54:42.032 CALL(IP) (00:00013:00) RTP: (Src) 10.129.47.16:8048 18:54:42.032 CALL(IP) (00:00013:00) RTP: (Dst) 10.129.47.12:10000 18:54:42.032 CALL(IP) (00:00013:00) Security on RTP(SRTP) Disabled mod: 0 vts 12 18:54:42.042 CALL(IP) (00:00013:00) SrcPortValidation: Enabled 18:54:42.042 CALL(IP) (00:00013:00) VoIP Codec is G711Mulaw; Payload Size is 2 0 ms 18:54:42.042 CALL(IP) (00:00013:00) Fax Mode is Bypass, Modem Mode is Bypass 18:54:42.042 CALL(IP) (00:00013:00) RFC2833 DTMF Relay in use, Dynamic Payload Type is 110 18:54:42.052 CALL(IP) (00:00013:00) Initial MID is disabled 18:54:42.052 CALL(IP) (00:00013:00) SENT Outseize ACK (toPvid: x66) to L3P 18:54:42.052 CALL(SIP) (00:00013:00) RCVD Outseize Ack from VPPL 18:54:42.052 CALL(SIP) (00:00013:00) SENT 183 Session Progress W/SDP to 10.129. 47.12:5060 UDP 18:54:42.052 CALL(SIP) (00:00013:00) <--- [10.129.47.12, 5060 <- 10.129.47.15, 5060] SIP/2.0 183 Session Progress\r\n Via: SIP/2.0/UDP 10.129.47.12:5060;received=10.129.47.12 \r\n Call-ID: 1-2032@10.129.47.12\r\n From: sipp <sip:8888@10.129.47.12:5060>;tag=1\r\n To: sut <sip:3387@10.129.47.15:5060>;tag=a94c095b773be1d d6e8d668a785a9c8443c1ac32\r\n Contact: <sip:3387@10.129.47.15:5060>\r\n CSeq: 1 INVITE\r\n Allow: OPTIONS, CANCEL, UPDATE\r\n Server: Dialogic-SIP/10.5.3.110 1010_Primary 0\r\n Content-Type: application/sdp\r\n Content-Length: 233\r\n \r\n v=0\r\n o=Dialogic_SDP 12 0 IN IP4 10.129.47.15\r\n s=Dialogic-SIP\r\n c=IN IP4 10.129.47.16\r\n t=0 0\r\n m=audio 8048 RTP/AVP 0 110\r\n a=rtpmap:0 PCMU/8000\r\n a=rtpmap:110 telephone-event/8000\r\n a=fmtp:110 0-15\r\n a=silenceSupp:off - - - -\r\n a=ptime:20\r\n 18:54:42.052 CALL(SIP) (00:00013:00) RCVD Cut Thru from VPPL 18:54:42.052 CALL(SIP) (00:00013:00) RCVD Connect from VPPL 18:54:45.032 CALL(SS7) (00:00013:01) RCVD: STK: 0 PRI: 00 DPC: 1-1-1 OPC: 2-2-2 SLS: 0x00 CIC: 00012 (0x000c) ANM [00] 18:54:45.032 CALL(SS7) (00:00013:01) RCVD ANM from (0x1012:0x809:12) 18:54:45.032 CALL(SS7) (00:00013:01) SENT Connect (0x1012:0x809:12) to L4 18:54:45.032 CALL(L4) (00:00013:01) RCVD Connect from SS7 18:54:45.032 CALL(L4) (00:00013:01) SENT CPE of ANSWER to GCL 18:54:45.032 CALL(GCL) (00:00013:01) RCVD CPE of ANSWER from L4 18:54:45.032 CALL(GCL) (00:00013:01) SENT Call Answered to GCL 18:54:45.032 CALL(GCL) (00:00013:00) SENT CPE of ANSWER to L4 18:54:45.032 CALL(L4) (00:00013:00) RCVD CPE of ANSWER from GCL 18:54:45.032 CALL(L4) (00:00013:00) SENT Connect to SIP 18:54:45.032 CALL(SIP) (00:00013:00) RCVD Connect from L4 18:54:45.032 CALL(SIP) (00:00013:00) Session Refresh is not Needed 18:54:45.032 CALL(SIP) (00:00013:00) SENT 200 OK INVITE W/SDP to 10.129.47.12:5 060 UDP 18:54:45.032 CALL(SIP) (00:00013:00) <--- [10.129.47.12, 5060 <- 10.129.47.15, 5060] SIP/2.0 200 OK\r\n Via: SIP/2.0/UDP 10.129.47.12:5060;received=10.129.47.12 \r\n Call-ID: 1-2032@10.129.47.12\r\n From: sipp <sip:8888@10.129.47.12:5060>;tag=1\r\n To: sut <sip:3387@10.129.47.15:5060>;tag=a94c095b773be1d d6e8d668a785a9c8443c1ac32\r\n Contact: <sip:3387@10.129.47.15:5060>\r\n CSeq: 1 INVITE\r\n Server: Dialogic-SIP/10.5.3.110 1010_Primary 0\r\n Allow: INVITE, BYE, REGISTER, ACK, OPTIONS, CANCEL, SUBS CRIBE, NOTIFY, INFO, REFER, UPDATE\r\n Supported: path, replaces, timer, tdialog\r\n Accept: application/sdp, application/dtmf-relay, text/pl ain\r\n Content-Type: application/sdp\r\n Content-Length: 233\r\n \r\n v=0\r\n o=Dialogic_SDP 12 0 IN IP4 10.129.47.15\r\n s=Dialogic-SIP\r\n c=IN IP4 10.129.47.16\r\n t=0 0\r\n m=audio 8048 RTP/AVP 0 110\r\n a=rtpmap:0 PCMU/8000\r\n a=rtpmap:110 telephone-event/8000\r\n a=fmtp:110 0-15\r\n a=silenceSupp:off - - - -\r\n a=ptime:20\r\n 18:54:45.042 CALL(SIP) (00:00013:00) RCVD ACK from 10.129.47.12:5060 udp CSeq:1 Msg Size:352 18:54:45.042 CALL(SIP) (00:00013:00) with Via sent-by: 10.129.47.12 udp 18:54:45.042 CALL(SIP) (00:00013:00) ---> [10.129.47.12, 5060] ACK sip:3387@10.129.47.15:5060 SIP/2.0\r\n Via: SIP/2.0/UDP 10.129.47.12:5060\r\n From: sipp <sip:8888@10.129.47.12:5060>;tag=1\r\n To: sut <sip:3387@10.129.47.15:5060>;tag=a94c095b773be1d d6e8d668a785a9c8443c1ac32\r\n Call-ID: 1-2032@10.129.47.12\r\n Cseq: 1 ACK\r\n Contact: sip:8888@10.129.47.12:5060\r\n Max-Forwards: 70\r\n Subject: Performance Test\r\n Content-Length: 0\r\n \r\n 18:54:48.062 CALL(SIP) (00:00013:00) RCVD INFO from 10.129.47.12:5060 udp CSeq: 2 Msg Size:389

 

Relevant section

18:54:48.062 CALL(SIP) (00:00013:00) ---> [10.129.47.12, 5060] INFO sip:3387@10.129.47.15:5060 SIP/2.0\r\n Via: SIP/2.0/UDP 10.129.47.12:5060\r\n From: sipp <sip:8888@10.129.47.12:5060>;tag=1\r\n To: sut <sip:3387@10.129.47.15:5060>;tag=a94c095b773be1d d6e8d668a785a9c8443c1ac32\r\n Call-ID: 1-2032@10.129.47.12\r\n Cseq: 2 INFO\r\n Contact: sip:8888@10.129.47.12:5060\r\n Max-Forwards: 70\r\n Subject: ITX rate\r\n Content-Type: text/plain\r\n Content-Length: 15\r\n \r\n C3=001,C2=002\r\n 18:54:48.062 CALL(SIP) (00:00013:00) INFO using sgp_id=1 18:54:48.062 CALL(SIP) (00:00013:00) RCVD INFO from 10.129.47.12:5060 udp CSeq: 2 Msg Size:389 18:54:48.062 CALL(SIP) (00:00013:00) INFO using sgp_id=1 18:54:48.062 CALL(SIP) (00:00013:00) spirou/itx payload detected(c2=2,c3=1)
18:54:48.062 CALL(SIP) (00:00013:00) SENT Mid Call Info to L4 18:54:48.062 CALL(SIP) (00:00013:00) SENT 200 OK INFO to 10.129.47.12:5060 UDP 18:54:48.062 CALL(SIP) (00:00013:00) <--- [10.129.47.12, 5060 <- 10.129.47.15, 5060] SIP/2.0 200 OK\r\n Via: SIP/2.0/UDP 10.129.47.12:5060;received=10.129.47.12 \r\n Call-ID: 1-2032@10.129.47.12\r\n From: sipp <sip:8888@10.129.47.12:5060>;tag=1\r\n To: sut <sip:3387@10.129.47.15:5060>;tag=a94c095b773be1d d6e8d668a785a9c8443c1ac32\r\n CSeq: 2 INFO\r\n Server: Dialogic-SIP/10.5.3.110 1010_Primary 0\r\n Allow: INVITE, BYE, REGISTER, ACK, OPTIONS, CANCEL, SUBS CRIBE, NOTIFY, INFO, REFER, UPDATE\r\n Accept: application/sdp, application/dtmf-relay, text/pl ain\r\n Accept-Encoding: identity\r\n Accept-Language: en\r\n Supported: path, replaces, timer, tdialog\r\n Content-Length: 0\r\n \r\n 18:54:48.062 CALL(L4) (00:00013:00) SENT Ppl Ev. Ind to GCL 18:54:48.062 CALL(GCL) (00:00013:01) SENT Ppl Ev. Req to L4 18:54:48.062 CALL(L4) (00:00013:01) SENT Ppl Ev. Req to SS7 18:54:48.062 CALL(SS7) (00:00013:01) RCVD PPL Event Request (0x809:0x1012:12) f rom L4 18:54:48.062 CALL(SS7) (00:00013:01) SENT: STK: 0 PRI: 00 DPC: 2-2-2 OPC: 1-1-1 SLS: 0x0c CIC: 00012 (0x000c) UDM1 [010200]

 

Relevant section

18:54:48.062 CALL(SS7) (00:00013:01) SENT USR_DEF1 to (0x809:0x1012:12) 18:54:48.112 CALL(SS7) (00:00013:01) RCVD: STK: 0 PRI: 00 DPC: 1-1-1 OPC: 2-2-2 SLS: 0x00 CIC: 00012 (0x000c) UDM2 [00] 18:54:48.112 CALL(SS7) (00:00013:01) RCVD USR_DEF2 from (0x1012:0x809:12) 18:54:49.082 CALL(SIP) (00:00013:00) RCVD INFO from 10.129.47.12:5060 udp CSeq: 3 Msg Size:387

Return to Documentation Home I Return to Sangoma Support