I can't make inbound and outbound calls to work it's always fast busy tone

[JH51928]

I have a sip trunk from Thinktel and have no credentials required. It was configured on 3cx phone system and now I moving it to Cisco ISR 4321 and CUCM.

I'm having difficulties trying to make inbound and outbound calls to work, it's always fast busy tone. Any help would be appreciated.

For Outbound calls - I'm getting SIP/2.0 408 Request Timeout and Q.850;cause=102

For Inbound calls - for some reason, I can't get any trace at all when I call the DID number.

Call Flow 

CIPC-->CUCM-->CUBE-->INTERNET ROUTER (TPLINK)--->ITSP

Here is the debug ccsip message

Jan 16 17:43:11.111: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:97053630968@10.3.3.1:5060 SIP/2.0
Via: SIP/2.0/TCP 10.3.3.2:5060;branch=z9hG4bK8e826f0d6bc
From: "CIPC" <sip:7052xxxxxx@10.3.3.2>;tag=40957~d4c37944-d9cb-465b-8c33-57c6ecc1433e-29681169
To: <sip:97053xxxxxx@10.3.3.1>
Date: Sat, 16 Jan 2021 17:43:11 GMT
Call-ID: 4bd8a700-3125af-8e68-203030a@10.3.3.2
Supported: timer,resource-priority,replaces
Min-SE: 1800
User-Agent: Cisco-CUCM12.0
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY
CSeq: 101 INVITE
Expires: 180
Allow-Events: presence, kpml
Supported: X-cisco-srtp-fallback,X-cisco-original-called
Call-Info: <sip:10.3.3.2:5060>;method="NOTIFY;Event=telephone-event;Duration=500"
Call-Info: <urn:x-cisco-remotecc:callinfo>;x-cisco-video-traffic-class=DESKTOP
Session-ID: 15dd5ee753c84d027ff309200aa40952;remote=00000000000000000000000000000000
Cisco-Guid: 1272489728-0000065536-0000000022-0033751818
Session-Expires: 1800
P-Asserted-Identity: "CIPC" <sip:7052xxxxxx@10.3.3.2>
Remote-Party-ID: "CIPC" <sip:7052xxxxxx@10.3.3.2>;party=calling;screen=yes;privacy=off
Contact: <sip:7052xxxxxx@10.3.3.2:5060;transport=tcp>
Max-Forwards: 69
Content-Type: application/sdp
Content-Length: 408

v=0
o=CiscoSystemsCCM-SIP 40957 1 IN IP4 10.3.3.2
s=SIP Call
c=IN IP4 172.16.16.108
b=TIAS:64000
b=AS:64
t=0 0
m=audio 32612 RTP/AVP 9 124 0 8 116 18 101
a=rtpmap:9 G722/8000
a=rtpmap:124 iSAC/16000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:116 iLBC/8000
a=maxptime:20
a=fmtp:116 mode=20
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

Jan 16 17:43:11.115: //29018/4BD8A7000000/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 10.3.3.2:5060;branch=z9hG4bK8e826f0d6bc
From: "CIPC" <sip:7052xxxxxx@10.3.3.2>;tag=40957~d4c37944-d9cb-465b-8c33-57c6ecc1433e-29681169
To: <sip:97053xxxxxx@10.3.3.1>
Date: Sat, 16 Jan 2021 12:43:11 GMT
Call-ID: 4bd8a700-3125af-8e68-203030a@10.3.3.2
CSeq: 101 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-15.5.3.S4b
Content-Length: 0

Jan 16 17:43:11.120: //29019/4BD8A7000000/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:7053xxxxxx@tor.trk.tprm.ca:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.20:5060;branch=z9hG4bK1244F
Remote-Party-ID: "CIPC" <sip:7052xxxxxx@172.16.16.20>;party=calling;screen=yes;privacy=off
From: "CIPC" <sip:7052xxxxxx@206.80.250.100>;tag=47523CC0-F03
To: <sip:7053xxxxxx@tor.trk.tprm.ca>
Date: Sat, 16 Jan 2021 12:43:11 GMT
Call-ID: 22B89469-575911EB-B1BCCF30-E2FF35CA@172.16.16.20
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE: 1800
Cisco-Guid: 1272489728-0000065536-0000000022-0033751818
User-Agent: Cisco-SIPGateway/IOS-15.5.3.S4b
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1610818991
Contact: <sip:7052xxxxxx@172.16.16.20:5060>
Expires: 180
Allow-Events: telephone-event
Max-Forwards: 68
Session-Expires: 1800
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 246

v=0
o=CiscoSystemsSIP-GW-UserAgent 3086 7263 IN IP4 172.16.16.20
s=SIP Call
c=IN IP4 172.16.16.20
t=0 0
m=audio 8080 RTP/AVP 0 101
c=IN IP4 172.16.16.20
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

Jan 16 17:43:11.620: //29019/4BD8A7000000/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:7053xxxxxx@tor.trk.tprm.ca:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.20:5060;branch=z9hG4bK1244F
Remote-Party-ID: "CIPC" <sip:7052xxxxxx@172.16.16.20>;party=calling;screen=yes;privacy=off
From: "CIPC" <sip:7052xxxxxx@206.80.250.100>;tag=47523CC0-F03
To: <sip:7053xxxxxx@tor.trk.tprm.ca>
Date: Sat, 16 Jan 2021 12:43:11 GMT
Call-ID: 22B89469-575911EB-B1BCCF30-E2FF35CA@172.16.16.20
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE: 1800
Cisco-Guid: 1272489728-0000065536-0000000022-0033751818
User-Agent: Cisco-SIPGateway/IOS-15.5.3.S4b
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1610818991
Contact: <sip:7052xxxxxx@172.16.16.20:5060>
Expires: 180
Allow-Events: telephone-event
Max-Forwards: 68
Session-Expires: 1800
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 246

v=0
o=CiscoSystemsSIP-GW-UserAgent 3086 7263 IN IP4 172.16.16.20
s=SIP Call
c=IN IP4 172.16.16.20
t=0 0
m=audio 8080 RTP/AVP 0 101
c=IN IP4 172.16.16.20
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

Jan 16 17:43:12.621: //29019/4BD8A7000000/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:7053xxxxxx@tor.trk.tprm.ca:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.20:5060;branch=z9hG4bK1244F
Remote-Party-ID: "CIPC" <sip:7052xxxxxx@172.16.16.20>;party=calling;screen=yes;privacy=off
From: "CIPC" <sip:7052xxxxxx@206.80.250.100>;tag=47523CC0-F03
To: <sip:7053xxxxxx@tor.trk.tprm.ca>
Date: Sat, 16 Jan 2021 12:43:12 GMT
Call-ID: 22B89469-575911EB-B1BCCF30-E2FF35CA@172.16.16.20
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE: 1800
Cisco-Guid: 1272489728-0000065536-0000000022-0033751818
User-Agent: Cisco-SIPGateway/IOS-15.5.3.S4b
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1610818992
Contact: <sip:7052xxxxxx@172.16.16.20:5060>
Expires: 180
Allow-Events: telephone-event
Max-Forwards: 68
Session-Expires: 1800
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 246

v=0
o=CiscoSystemsSIP-GW-UserAgent 3086 7263 IN IP4 172.16.16.20
s=SIP Call
c=IN IP4 172.16.16.20
t=0 0
m=audio 8080 RTP/AVP 0 101
c=IN IP4 172.16.16.20
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

Jan 16 17:43:14.621: //29018/4BD8A7000000/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 408 Request Timeout
Via: SIP/2.0/TCP 10.3.3.2:5060;branch=z9hG4bK8e826f0d6bc
From: "CIPC" <sip:7052xxxxxx@10.3.3.2>;tag=40957~d4c37944-d9cb-465b-8c33-57c6ecc1433e-29681169
To: <sip:97053xxxxxx@10.3.3.1>;tag=47524A6E-2645
Date: Sat, 16 Jan 2021 12:43:11 GMT
Call-ID: 4bd8a700-3125af-8e68-203030a@10.3.3.2
CSeq: 101 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-15.5.3.S4b
Reason: Q.850;cause=102
Content-Length: 0

Jan 16 17:43:14.623: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:97053xxxxxx@10.3.3.1:5060 SIP/2.0
Via: SIP/2.0/TCP 10.3.3.2:5060;branch=z9hG4bK8e826f0d6bc
From: "CIPC" <sip:7052xxxxxx@10.3.3.2>;tag=40957~d4c37944-d9cb-465b-8c33-57c6ecc1433e-29681169
To: <sip:97053xxxxxx@10.3.3.1>;tag=47524A6E-2645
Date: Sat, 16 Jan 2021 17:43:11 GMT
Call-ID: 4bd8a700-3125af-8e68-203030a@10.3.3.2
User-Agent: Cisco-CUCM12.0
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: presence, kpml
Content-Length: 0

Jan 16 17:43:19.487: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
OPTIONS sip:10.3.3.1:5060 SIP/2.0
Via: SIP/2.0/TCP 10.3.3.2:5060;branch=z9hG4bK8e847a1fe3f8
From: <sip:10.3.3.2>;tag=1036888340
To: <sip:10.3.3.1>
Date: Sat, 16 Jan 2021 17:43:19 GMT
Call-ID: 509d5b00-3125b7-8e6a-203030a@10.3.3.2
User-Agent: Cisco-CUCM12.0
CSeq: 101 OPTIONS
Contact: <sip:10.3.3.2:5060;transport=tcp>
Max-Forwards: 0
Content-Length: 0

Jan 16 17:43:19.488: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.3.3.2:5060;branch=z9hG4bK8e847a1fe3f8
From: <sip:10.3.3.2>;tag=1036888340
To: <sip:10.3.3.1>;tag=47525D70-E35
Date: Sat, 16 Jan 2021 12:43:19 GMT
Call-ID: 509d5b00-3125b7-8e6a-203030a@10.3.3.2
Server: Cisco-SIPGateway/IOS-15.5.3.S4b
CSeq: 101 OPTIONS
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
Allow-Events: telephone-event
Accept: application/sdp
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Content-Type: application/sdp
Content-Length: 157

v=0
o=CiscoSystemsSIP-GW-UserAgent 9818 2626 IN IP4 10.3.3.1
s=SIP Call
c=IN IP4 10.3.3.1
t=0 0
m=audio 0 RTP/AVP 18 0 8 9 4 2 15 3
c=IN IP4 10.3.3.1

Here is my ISR config

ip name-server 216.104.96.22

!
voice service voip
ip address trusted list
ipv4 10.3.3.2
ipv4 206.80.250.100
mode border-element
allow-connections h323 to h323
allow-connections h323 to sip
allow-connections sip to h323
allow-connections sip to sip
sip
registrar server
early-offer forced
!
voice class codec 1
codec preference 1 g711ulaw
!
!
voice translation-rule 10
rule 10 /^9/ //
!
!
voice translation-profile OUT-STRIP9
translate called 10
!
!
interface GigabitEthernet0/0/0
ip address 172.16.16.20 255.255.255.0
ip nat outside
negotiation auto
!
interface GigabitEthernet0/0/1
ip address 10.3.3.1 255.255.255.0
negotiation auto
!
interface GigabitEthernet0
vrf forwarding Mgmt-intf
no ip address
shutdown
negotiation auto
!
interface Vlan1
no ip address
shutdown
!
ip nat inside source list 101 interface GigabitEthernet0/0/0 overload
ip forward-protocol nd
no ip http server
no ip http secure-server
ip tftp source-interface GigabitEthernet0
ip route 0.0.0.0 0.0.0.0 172.16.16.1
ip route 10.3.3.0 255.255.255.0 172.16.16.1
ip route 172.16.16.0 255.255.255.0 172.16.16.1
!
!
access-list 101 permit ip host 10.3.3.0 any
!
!
mgcp behavior rsip-range tgcp-only
mgcp behavior comedia-role none
mgcp behavior comedia-check-media-src disable
mgcp behavior comedia-sdp-force disable
!
mgcp profile default
!
!
!
!
dial-peer voice 1 voip
description INCOMING FROM ITSP/CUCM
session protocol sipv2
incoming called-number .
voice-class codec 1
dtmf-relay rtp-nte sip-kpml
!
dial-peer voice 11 voip
description OUTGOING TO CUCM
answer-address .
destination-pattern ^..........$
session protocol sipv2
session target ipv4:10.3.3.2
voice-class codec 1
dtmf-relay rtp-nte sip-kpml
!
dial-peer voice 22 voip
description OUTGOING TO ITSP
translation-profile outgoing OUT-STRIP9
destination-pattern 9[2-9]..[2-9]......$
session protocol sipv2
session target dns:tor.trk.tprm.ca
voice-class codec 1
voice-class sip bind control source-interface GigabitEthernet0/0/0
voice-class sip bind media source-interface GigabitEthernet0/0/0
dtmf-relay rtp-nte sip-kpml
no vad
!
!
sip-ua
retry invite 2
registrar ipv4:206.80.250.100 expires 3600
sip-server dns:tor.trk.tprm.ca
!

[JH51928]

---

@Roger Kallberg wrote:

Remove these lines from your configuration.

• registrar ipv4:206.80.250.100 expires 3600
• registrar server

The first one is under sip-ua and the second is under voice service voip / sip. Likely you can also remove this sip-server dns:tor.trk.tprm.ca from sip-ua.

Once done with these changes please post your current configuration so that we can verify it.

---

I  added some of the commands but not all yet.

I still can't make an inbound and outbound calls, same issue.

CALL FLOW

Phone--CUCM--ISR--Internet gateway--ITSP (using IP based Sip trunk, no registration)

CUCM - 10.3.3.2

ISR interface gigabit0/0/0 (to ITSP) - 17.16.16.20

ISR interface gigabit0/0/1 (to CUCM) - 10.3.3.1

ITSP - 206.80.250.100

 INTERNET GATEWAY - 17.16.16.1

On the ISR - added a static route to get to ITSP - 0.0.0.0 0.0.0.0 17.16.16.1

On the INTERNET GATEWAY - added a static route to get to CUCM - 10.3.3.0 255.255.255.0 17.16.16.20

CONFIG

voice service voip
ip address trusted list
ipv4 10.3.3.2
ipv4 206.80.250.100 255.255.255.255
ipv4 208.68.17.32 255.255.255.224
ipv4 209.197.133.0 255.255.255.192
mode border-element
allow-connections h323 to h323
allow-connections h323 to sip
allow-connections sip to h323
allow-connections sip to sip
!
!
voice class uri 2 sip
host ipv4:10.3.3.2
voice class codec 1
codec preference 1 g711ulaw
!
!
!
!
!
!
voice translation-rule 10
rule 10 /^9/ //
!
!
voice translation-profile OUT-STRIP9
translate called 10
!
!
!
interface GigabitEthernet0/0/0
ip address 172.16.16.20 255.255.255.0
negotiation auto
!
interface GigabitEthernet0/0/1
ip address 10.3.3.1 255.255.255.0
negotiation auto
!
interface GigabitEthernet0
vrf forwarding Mgmt-intf
no ip address
shutdown
negotiation auto
!
interface Vlan1
no ip address
shutdown
!
ip forward-protocol nd
no ip http server
no ip http secure-server
ip tftp source-interface GigabitEthernet0
ip route 0.0.0.0 0.0.0.0 172.16.16.1
!
control-plane
!
!
!
mgcp behavior rsip-range tgcp-only
mgcp behavior comedia-role none
mgcp behavior comedia-check-media-src disable
mgcp behavior comedia-sdp-force disable
!
mgcp profile default
!
!
!
!
dial-peer voice 1 voip
description INCOMING FROM ITSP
session protocol sipv2
incoming called-number 7052690092
voice-class codec 1
voice-class sip bind control source-interface GigabitEthernet0/0/0
voice-class sip bind media source-interface GigabitEthernet0/0/0
dtmf-relay rtp-nte sip-kpml
no vad
!
dial-peer voice 11 voip
description OUTGOING TO CUCM
destination-pattern 7052690092
session protocol sipv2
session target ipv4:10.3.3.2
voice-class codec 1
voice-class sip bind control source-interface GigabitEthernet0/0/1
voice-class sip bind media source-interface GigabitEthernet0/0/1
dtmf-relay rtp-nte sip-kpml
no vad
!
dial-peer voice 22 voip
description OUTGOING TO ITSP
translation-profile outgoing OUT-STRIP9
destination-pattern 9[2-9]..[2-9]......$
session protocol sipv2
session target ipv4:206.80.250.100
voice-class codec 1
voice-class sip early-offer forced
voice-class sip bind control source-interface GigabitEthernet0/0/0
voice-class sip bind media source-interface GigabitEthernet0/0/0
dtmf-relay rtp-nte sip-kpml
no vad
!
dial-peer voice 2 voip
description INCOMING FROM CUCM
session protocol sipv2
incoming uri via 2
voice-class codec 1
dtmf-relay rtp-nte sip-kpml
no vad
!
!
sip-ua
retry invite 2

DEBUG CCSIP MESS

Jan 24 05:11:43.598: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:97053xxxxxx@10.3.3.1:5060 SIP/2.0
Via: SIP/2.0/TCP 10.3.3.2:5060;branch=z9hG4bKe1d1586583e2
From: "CIPC" <sip:7052xxxxxx@10.3.3.2>;tag=68002~d4c37944-d9cb-465b-8c33-57c6ecc1433e-29681259
To: <sip:97053xxxxxx@10.3.3.1>
Date: Sun, 24 Jan 2021 05:11:43 GMT
Call-ID: a49bd700-d1018f-e19d-203030a@10.3.3.2
Supported: timer,resource-priority,replaces
Min-SE: 1800
User-Agent: Cisco-CUCM12.0
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY
CSeq: 101 INVITE
Expires: 180
Allow-Events: presence, kpml
Supported: X-cisco-srtp-fallback,X-cisco-original-called
Call-Info: <sip:10.3.3.2:5060>;method="NOTIFY;Event=telephone-event;Duration=500"
Call-Info: <urn:x-cisco-remotecc:callinfo>;x-cisco-video-traffic-class=DESKTOP
Session-ID: 15dd5ee753c84d027ff309200aa67998;remote=00000000000000000000000000000000
Cisco-Guid: 2761676544-0000065536-0000000054-0033751818
Session-Expires: 1800
P-Asserted-Identity: "CIPC" <sip:7052xxxxxx@10.3.3.2>
Remote-Party-ID: "CIPC" <sip:7052xxxxxx@10.3.3.2>;party=calling;screen=yes;privacy=off
Contact: <sip:7052xxxxxx@10.3.3.2:5060;transport=tcp>
Max-Forwards: 69
Content-Type: application/sdp
Content-Length: 408

v=0
o=CiscoSystemsCCM-SIP 68002 1 IN IP4 10.3.3.2
s=SIP Call
c=IN IP4 172.16.16.108
b=TIAS:64000
b=AS:64
t=0 0
m=audio 32210 RTP/AVP 9 124 0 8 116 18 101
a=rtpmap:9 G722/8000
a=rtpmap:124 iSAC/16000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:116 iLBC/8000
a=maxptime:20
a=fmtp:116 mode=20
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

Jan 24 05:11:43.601: //50137/A49BD7000000/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 10.3.3.2:5060;branch=z9hG4bKe1d1586583e2
From: "CIPC" <sip:7052xxxxxx@10.3.3.2>;tag=68002~d4c37944-d9cb-465b-8c33-57c6ecc1433e-29681259
To: <sip:97053xxxxxx@10.3.3.1>
Date: Sun, 24 Jan 2021 00:11:43 GMT
Call-ID: a49bd700-d1018f-e19d-203030a@10.3.3.2
CSeq: 101 INVITE
Allow-Events: kpml, telephone-event
Server: Cisco-SIPGateway/IOS-15.5.3.S4b
Content-Length: 0

Jan 24 05:11:43.604: //50138/A49BD7000000/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:7053xxxxxx@206.80.250.100:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.20:5060;branch=z9hG4bK32109F
Remote-Party-ID: "CIPC" <sip:7052xxxxxx@172.16.16.20>;party=calling;screen=yes;privacy=off
From: "CIPC" <sip:7052xxxxxx@172.16.16.20>;tag=6DD521A4-42F
To: <sip:7053xxxxxx@206.80.250.100>
Date: Sun, 24 Jan 2021 00:11:43 GMT
Call-ID: 7BC612D8-5D3911EB-84B7CF30-E2FF35CA@172.16.16.20
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE: 1800
Cisco-Guid: 2761676544-0000065536-0000000054-0033751818
User-Agent: Cisco-SIPGateway/IOS-15.5.3.S4b
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1611465103
Contact: <sip:7052xxxxxx@172.16.16.20:5060>
Expires: 180
Allow-Events: kpml, telephone-event
Max-Forwards: 68
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 247

v=0
o=CiscoSystemsSIP-GW-UserAgent 2157 3324 IN IP4 172.16.16.20
s=SIP Call
c=IN IP4 172.16.16.20
t=0 0
m=audio 16418 RTP/AVP 0 101
c=IN IP4 172.16.16.20
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

Jan 24 05:11:44.103: //50138/A49BD7000000/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:7053xxxxxx@206.80.250.100:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.20:5060;branch=z9hG4bK32109F
Remote-Party-ID: "CIPC" <sip:7052xxxxxx@172.16.16.20>;party=calling;screen=yes;privacy=off
From: "CIPC" <sip:7052xxxxxx@172.16.16.20>;tag=6DD521A4-42F
To: <sip:7053xxxxxx@206.80.250.100>
Date: Sun, 24 Jan 2021 00:11:44 GMT
Call-ID: 7BC612D8-5D3911EB-84B7CF30-E2FF35CA@172.16.16.20
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE: 1800

Cisco-Guid: 2761676544-0000065536-0000000054-0033751818
User-Agent: Cisco-SIPGateway/IOS-15.5.3.S4b
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1611465104
Contact: <sip:7052xxxxxx@172.16.16.20:5060>
Expires: 180
Allow-Events: kpml, telephone-event
Max-Forwards: 68
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 247

v=0
o=CiscoSystemsSIP-GW-UserAgent 2157 3324 IN IP4 172.16.16.20
s=SIP Call
c=IN IP4 172.16.16.20
t=0 0
m=audio 16418 RTP/AVP 0 101
c=IN IP4 172.16.16.20
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

Jan 24 05:11:45.104: //50138/A49BD7000000/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:7053xxxxxx@206.80.250.100:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.16.20:5060;branch=z9hG4bK32109F
Remote-Party-ID: "CIPC" <sip:7052xxxxxx@172.16.16.20>;party=calling;screen=yes;privacy=off
From: "CIPC"<sip:7052xxxxxx@172.16.16.20>;tag=6DD521A4-42F
To: <sip:7053xxxxxx@206.80.250.100>
Date: Sun, 24 Jan 2021 00:11:45 GMT
Call-ID: 7BC612D8-5D3911EB-84B7CF30-E2FF35CA@172.16.16.20
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE: 1800
Cisco-Guid: 2761676544-0000065536-0000000054-0033751818
User-Agent: Cisco-SIPGateway/IOS-15.5.3.S4b
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1611465105

Contact: <sip:7052xxxxxx@172.16.16.20:5060>
Expires: 180
Allow-Events: kpml, telephone-event
Max-Forwards: 68
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 247

v=0
o=CiscoSystemsSIP-GW-UserAgent 2157 3324 IN IP4 172.16.16.20
s=SIP Call
c=IN IP4 172.16.16.20
t=0 0
m=audio 16418 RTP/AVP 0 101
c=IN IP4 172.16.16.20
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

Jan 24 05:11:47.105: //50137/A49BD7000000/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 408 Request Timeout
Via: SIP/2.0/TCP 10.3.3.2:5060;branch=z9hG4bKe1d1586583e2
From: "CIPC" <sip:7052xxxxxx@10.3.3.2>;tag=68002~d4c37944-d9cb-465b-8c33-57c6ecc1433e-29681259
To: <sip:97053xxxxxx@10.3.3.1>;tag=6DD52F52-665
Date: Sun, 24 Jan 2021 00:11:43 GMT
Call-ID: a49bd700-d1018f-e19d-203030a@10.3.3.2
CSeq: 101 INVITE
Allow-Events: kpml, telephone-event
Server: Cisco-SIPGateway/IOS-15.5.3.S4b
Reason: Q.850;cause=102
Content-Length: 0

Jan 24 05:11:47.107: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:97053xxxxxx@10.3.3.1:5060 SIP/2.0
Via: SIP/2.0/TCP 10.3.3.2:5060;branch=z9hG4bKe1d1586583e2
From: "CIPC" <sip:7052xxxxxx@10.3.3.2>;tag=68002~d4c37944-d9cb-465b-8c33-57c6ecc1433e-29681259
To: <sip:97053xxxxxx@10.3.3.1>;tag=6DD52F52-665
Date: Sun, 24 Jan 2021 05:11:43 GMT
Call-ID: a49bd700-d1018f-e19d-203030a@10.3.3.2
User-Agent: Cisco-CUCM12.0
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: presence, kpml
Content-Length: 0

DEBUG CCAPI INOUT

Jan 24 05:13:11.554: //-1/D90F93000000/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=7052xxxxxx
----- ccCallInfo IE subfields -----
cisco-ani=sip:7052xxxxxx@10.3.3.2
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=1
dest=sip:97053xxxxxx@10.3.3.1:5060
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFFFFFFFFFF
cisco-rdn=
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=-1
cisco-rdnsi=-1
cisco-redirectreason=-1 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0

Jan 24 05:13:11.554: //-1/D90F93000000/CCAPI/cc_api_call_setup_ind_common:
Interface=0x7F2DC9E502C0, Call Info(
Calling Number=sip:7052xxxxxx@10.3.3.2,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
Called Number=sip:97053xxxxxx@10.3.3.1:5060(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
Incoming Dial-peer=2, Progress Indication=NULL(0), Calling IE Present=TRUE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=50141
Jan 24 05:13:11.554: //-1/D90F93000000/CCAPI/ccCheckClipClir:
In: Calling Number=sip:7052xxxxxx@10.3.3.2(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
Jan 24 05:13:11.554: //-1/D90F93000000/CCAPI/ccCheckClipClir:
Out: Calling Number=sip:7052xxxxxx@10.3.3.2(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
Jan 24 05:13:11.554: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 05:13:11.555: :cc_get_feature_vsa malloc success
Jan 24 05:13:11.555: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 05:13:11.555: cc_get_feature_vsa count is 1
Jan 24 05:13:11.555: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 05:13:11.555: :FEATURE_VSA attributes are: feature_name:0,feature_time:139834707010052,feature_id:108
Jan 24 05:13:11.555: //50141/D90F93000000/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
Called Number=(TON=Unknown, NPI=Unknown))
Jan 24 05:13:11.555: //50141/D90F93000000/CCAPI/cc_process_call_setup_ind:
Event=0x7F2DCE2EC4C8
Jan 24 05:13:11.555: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number 97053xxxxxx
Jan 24 05:13:11.555: //50141/D90F93000000/CCAPI/ccCallSetContext:
Context=0x7F2DD2849330
Jan 24 05:13:11.555: //50141/D90F93000000/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 50141 with tag 2 to app "_ManagedAppProcess_Default"
Jan 24 05:13:11.555: //50141/D90F93000000/CCAPI/ccCallProceeding:
Progress Indication=NULL(0)
Jan 24 05:13:11.556: //50141/D90F93000000/CCAPI/ccCallSetupRequest:
Destination=, Calling IE Present=TRUE, Mode=0,
Outgoing Dial-peer=22, Params=0x7F2DD2847D08, Progress Indication=NULL(0)
Jan 24 05:13:11.556: //50141/D90F93000000/CCAPI/ccCheckClipClir:
In: Calling Number=7052xxxxxx(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
Jan 24 05:13:11.556: //50141/D90F93000000/CCAPI/ccCheckClipClir:
Out: Calling Number=7052xxxxxx(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed)
Jan 24 05:13:11.556: //50141/D90F93000000/CCAPI/ccCallSetupRequest:
Destination Pattern=9[2-9]..[2-9]......$, Called Number=7053xxxxxx, Digit Strip=FALSE
Jan 24 05:13:11.556: //50141/D90F93000000/CCAPI/ccCallSetupRequest:
Calling Number=7052xxxxxx(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
Called Number=7053xxxxxx(TON=Unknown, NPI=Unknown),
Redirect Number=, Display Info=CIPC
Account Number=7052xxxxxx, Final Destination Flag=TRUE,
Guid=D90F9300-0001-0000-0000-00370203030A, Outgoing Dial-peer=22
Jan 24 05:13:11.556: //50141/D90F93000000/CCAPI/cc_api_display_ie_subfields:
ccCallSetupRequest:
cisco-username=7052xxxxxx
----- ccCallInfo IE subfields -----
cisco-ani=7052xxxxxx
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=1
dest=7053xxxxxx
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFFFFFFFFFF
cisco-rdn=
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=-1
cisco-rdnsi=-1
cisco-redirectreason=-1 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0

Jan 24 05:13:11.556: //50141/D90F93000000/CCAPI/ccIFCallSetupRequestPrivate:
Interface=0x7F2DC9E502C0, Interface Type=3, Destination=, Mode=0x0,
Call Params(Calling Number=7052xxxxxx,(Calling Name=CIPC)(TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed),
Called Number=7053xxxxxx(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=22, Call Count On=FALSE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
Jan 24 05:13:11.556: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 05:13:11.556: :cc_get_feature_vsa malloc success
Jan 24 05:13:11.556: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 05:13:11.556: cc_get_feature_vsa count is 2
Jan 24 05:13:11.556: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

Jan 24 05:13:11.556: :FEATURE_VSA attributes are: feature_name:0,feature_time:139834707010276,feature_id:109
Jan 24 05:13:11.557: //50141/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Jan 24 05:13:11.557: cc_api_get_xcode_stream : 4983
Jan 24 05:13:11.557: //50141/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Jan 24 05:13:11.557: cc_api_get_xcode_stream : 4983
Jan 24 05:13:11.557: //50141/D90F93000000/CCAPI/cc_api_event_indication:
Event=101, Call Id=50141
Jan 24 05:13:11.557: //50141/D90F93000000/CCAPI/cc_api_event_indication:
Event Is Sent To Conferenced SPI(s) Directly
Jan 24 05:13:11.557: //50142/D90F93000000/CCAPI/ccIFCallSetupRequestPrivate:
SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
Jan 24 05:13:11.557: //50142/D90F93000000/CCAPI/ccCallSetContext:
Context=0x7F2DD2847C88
Jan 24 05:13:11.557: //50141/D90F93000000/CCAPI/ccSaveDialpeerTag:
Outgoing Dial-peer=22
Jan 24 05:13:11.557: //50142/D90F93000000/CCAPI/ccGetMediaClassTag:
media class tag 0
Jan 24 05:13:11.557: //50142/D90F93000000/CCAPI/ccSetMediaclassIp2ipTags:
media class tags set: NR 0, ASP 0
Jan 24 05:13:11.557: //50141/D90F93000000/CCAPI/ccGetMediaClassTag:
media class tag 0
Jan 24 05:13:11.557: //50141/D90F93000000/CCAPI/ccSetMediaclassIp2ipTags:
media class tags set: NR 0, ASP 0
Jan 24 05:13:11.557: //50142/D90F93000000/CCAPI/ccGet_xc_nr_asp_info:
media class tags: NR 0, ASP 0
Jan 24 05:13:11.557: //50141/D90F93000000/CCAPI/ccGet_xc_nr_asp_info:
media class tags: NR 0, ASP 0
Jan 24 05:13:11.557: //-1/xxxxxxxxxxxx/CCAPI/cc_is_cng_fax_detect_active:
Call Id 50141
Jan 24 05:13:11.558: //50142/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Jan 24 05:13:11.558: cc_api_get_xcode_stream : 4983
Jan 24 05:13:11.558: //50142/D90F93000000/CCAPI/cc_api_call_proceeding:
Interface=0x7F2DC9E502C0, Progress Indication=NULL(0)
Jan 24 05:13:11.559: //50142/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Jan 24 05:13:11.559: cc_api_get_xcode_stream : 4983
Jan 24 05:13:11.559: //50142/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

Jan 24 05:13:11.559: cc_api_get_xcode_stream : 4983
Jan 24 05:13:15.058: //50142/D90F93000000/CCAPI/cc_api_call_disconnected:
Cause Value=102, Interface=0x7F2DC9E502C0, Call Id=50142
Jan 24 05:13:15.058: //50142/D90F93000000/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=TRUE, Cause Value=102, Retry Count=0)
Jan 24 05:13:15.058: //50141/D90F93000000/CCAPI/ccCallReleaseResources:
release reserved xcoding resource.
Jan 24 05:13:15.058: //50142/D90F93000000/CCAPI/ccCallSetAAA_Accounting:
Accounting=0, Call Id=50142
Jan 24 05:13:15.058: //50142/D90F93000000/CCAPI/ccCallDisconnect:
Cause Value=102, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=102)
Jan 24 05:13:15.058: //50142/D90F93000000/CCAPI/ccCallDisconnect:
Cause Value=102, Call Entry(Responsed=TRUE, Cause Value=102)
Jan 24 05:13:15.058: //50142/D90F93000000/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x7F2DC9E502C0, Tag=0x0, Call Id=50142,
Call Entry(Disconnect Cause=102, Voice Class Cause Code=0, Retry Count=0)
Jan 24 05:13:15.058: //50142/D90F93000000/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
Jan 24 05:13:15.058: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 05:13:15.058: :cc_free_feature_vsa freeing 7F2DCE09E2D8
Jan 24 05:13:15.058: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 05:13:15.059: vsacount in free is 1
Jan 24 05:13:15.059: //50141/D90F93000000/CCAPI/ccCallDisconnect:
Cause Value=102, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Jan 24 05:13:15.059: //50141/D90F93000000/CCAPI/ccCallDisconnect:
Cause Value=102, Call Entry(Responsed=TRUE, Cause Value=102)

Jan 24 05:13:15.063: //50141/D90F93000000/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x7F2DC9E502C0, Tag=0x0, Call Id=50141,
Call Entry(Disconnect Cause=102, Voice Class Cause Code=0, Retry Count=0)
Jan 24 05:13:15.064: //50141/D90F93000000/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
Jan 24 05:13:15.064: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 05:13:15.064: :cc_free_feature_vsa freeing 7F2DCE09E1F8
Jan 24 05:13:15.064: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

Jan 24 05:13:15.064: vsacount in free is 0

[Roger Kallberg]

In the debug we can see that you are sending 3 invites to the telco, but you are not getting any reply. You need to check again with them if they send anything back to you. If they do you need to check your internet gateway so that it allows the traffic.

[Shalid Kurunnan Chalil]

Hi @JH51928 

As @Roger Kallberg mentioned, you are not getting any response for your invite from the ITSP side to the CUBE. Please check your firewall settings and ensure that it is not blocking anything?

Regards,

[JH51928]

---

@Roger Kallberg wrote:

In the debug we can see that you are sending 3 invites to the telco, but you are not getting any reply. You need to check again with them if they send anything back to you. If they do you need to check your internet gateway so that it allows the traffic.

---

The ports 5060 and 16384-32766 have been forwarded already to 172.16.16.20 (cube interface Gib0/0/0)

I've even disabled the sip-alg on the internet router and I still can't get any traces on inbound call.

I'll contact itsp first thing tomorrow to see what;s going on.  

[Scott Leport]

Hi there,

Some great advice from Roger here, but I just want to circle back to your original point re the inbound calls "For Inbound calls - for some reason, I can't get any trace at all when I call the DID number."

Can you clarify what you mean by that? Are you running a debug ccsip messages and you're not seeing output on your CUBE when you make an inbound call? If you are not seeing any SIP messaging delivered to your CUBE when you're making incoming calls, then you would need to raise that with your ITSP.

[JH51928]

I called the ITSP several times about the inbound call. I even requested to look for traces if the call is going on their end, he tried to look for traces and didn't find any. I asked him why he can't find it, he replied that I should ask cisco about my configuration, because they are not getting any traces of the call. I've got confused, the call should go to ITSP first, I don't know why he said that. 

I stopped working on this, the ITSP does not want to help, he does not even provide traces.

About the outbound call, I found out a guide on the internet about it. They have preferred sip profiles that is why my outbound calls are always busy/rejected. 

[Scott Leport]

Hi there,

Forgot about this one!

Not sure if you still have the appetite for it or not, but during the troubleshooting have you verified if you're seeing any traffic on your TP-Link router when you make an inbound or outbound call over the SIP trunk? This would be handy certainly for inbound because if the ITSP have done their job, you should be seeing inbound attempts from their SBC to your TP-Link on UDP port 5060.If you're not seeing that and your logging is operational, escalate it.