Unable to make or receive calls on sip trunk

[j_redhead]

Good day,

I recently taken on a new client with an IPO that was relocated from one office to another location. They have added a sip trunk, the trunk has been configured and shows idle state in system status. However I am unable to make nor receive calls. On incoming calls I am getting an error message stating "the number you have dialed is not in service".

The service provider has stated that all configurations on their side is good which I find hard to believe as incoming calls are not even ringing at all. I have run a monitor trace which is attached below. Also the system status shows some sort of activity when the line is called where the time in state is reset as if it is attempting to initiate the call.

 

[j_redhead]

12:12:44 422059440mS RES: Mon 15/11/2021 12:12:43 FreeMem=55593080 (Heap=55278100(3) + Cache=314980) MemObjs=11749(Max 12482) CMMsg=4(7) Buff=5200 1349 1000 7444 5 Links=56105(58000) BTree=14178 CPU=04.51% CPUStats=13.98%/5/20/2525/17278/20019/00.00%/1/
02.54% MCR=0 MCW=0
12:12:44 422059441mS RES2: IP 500 V2 9.1.0.0 build 437 Tasks=56 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=66 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=1 TCP=23(TLS=3) TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
12:12:44 422059441mS RES4: XML MemObjs=63 PoolMem=4876404(2) FreeMem=4861100(0)
12:12:44 422059441mS RES5: CLog MemObjs=345 FreePoolMem(Objs)=8060(155) TotalMem=129600
12:12:45 422060704mS ERR: EVM 6p1 upgrade file clips missing: ENG
12:12:45 422060704mS ERR: Park & Page 8p0 upgrade file clips missing: ENG
12:12:45 422060707mS ERR: EVM 9p0 upgrade file clips missing: ENG
12:12:45 422060707mS ERR: EVM 9p1 upgrade file clips missing: ENG
12:12:45 422060715mS ERR: EVM 7p0 upgrade file clips missing: ENG
12:12:45 422060739mS ERR: EVM Intuity 8p0 upgrade file clips missing: ENG
12:12:45 422060741mS ERR: EVM Intuity clips A 8p0 upgrade file clips missing: ENG
12:12:47 422062977mS SIP Rx: UDP 172.29.0.5:5060 -> 192.168.145.40:5060
INVITE sip:6094055@192.168.145.40 SIP/2.0
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPjbd507d70-b4f0-4557-be62-ea8ae36dbe94
From: "18683555315" <sip:18683555315@192.168.200.173>;tag=982b1d59-35ea-4780-b40d-6796219adc1f
To: <sip:6094055@192.168.145.40>
Contact: <sip:asterisk@172.29.0.5:5060>
Call-ID: 2bebabe1-764f-43e1-9303-5a713620cbfe
CSeq: 21026 INVITE
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Supported: 100rel, timer, replaces, norefersub, histinfo
Session-Expires: 1800
Min-SE: 90
Max-Forwards: 70
User-Agent: FPBX-15.0.17.62(16.17.0)
Content-Type: application/sdp
Content-Length: 333

v=0
o=- 522317520 522317520 IN IP4 172.29.0.5
s=Asterisk
c=IN IP4 172.29.0.5
t=0 0
m=audio 18456 RTP/AVP 0 8 3 111 9 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:111 G726-32/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv
12:12:47 422062981mS SIP Call Rx: 17
INVITE sip:6094055@192.168.145.40 SIP/2.0
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPjbd507d70-b4f0-4557-be62-ea8ae36dbe94
From: "18683555315" <sip:18683555315@192.168.200.173>;tag=982b1d59-35ea-4780-b40d-6796219adc1f
To: <sip:6094055@192.168.145.40>
Contact: <sip:asterisk@172.29.0.5:5060>
Call-ID: 2bebabe1-764f-43e1-9303-5a713620cbfe
CSeq: 21026 INVITE
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Supported: 100rel, timer, replaces, norefersub, histinfo
Session-Expires: 1800
Min-SE: 90
Max-Forwards: 70
User-Agent: FPBX-15.0.17.62(16.17.0)
Content-Type: application/sdp
Content-Length: 333

v=0
o=- 522317520 522317520 IN IP4 172.29.0.5
s=Asterisk
c=IN IP4 172.29.0.5
t=0 0
m=audio 18456 RTP/AVP 0 8 3 111 9 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:111 G726-32/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv
12:12:47 422062982mS Sip: SIP Line (17): sip_trunk_config_items 00020001, voip.flags 00000948
12:12:47 422062982mS Sip: SIPDialog f17bafec created, dialogs 1
12:12:47 422062983mS Stun: Info: Line 17: Not using STUN for media in this case.
12:12:47 422062983mS Sip: SIP Line (17): License, Valid 1, Available 4, Consumed 0
12:12:47 422062984mS Sip: SIPTrunkEndpointDialogOwner::SetRemoteAddressForRequest from 172.29.0.5:5060 to 172.29.0.5:5060
12:12:47 422062984mS Sip: SIPTrunkEndpointDialogOwner::SetRemoteAddressForResponse from 172.29.0.5:5060 to 172.29.0.5:5060
12:12:47 422062986mS SIP Call Tx: 17
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPjbd507d70-b4f0-4557-be62-ea8ae36dbe94
From: "18683555315" <sip:18683555315@192.168.200.173>;tag=982b1d59-35ea-4780-b40d-6796219adc1f
Call-ID: 2bebabe1-764f-43e1-9303-5a713620cbfe
CSeq: 21026 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.1.0.0 build 437
To: <sip:6094055@192.168.145.40>;tag=9d4e9f080d0cbcf0
Content-Length: 0

12:12:47 422062986mS SIP Tx: UDP 192.168.145.40:5060 -> 172.29.0.5:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPjbd507d70-b4f0-4557-be62-ea8ae36dbe94
From: "18683555315" <sip:18683555315@192.168.200.173>;tag=982b1d59-35ea-4780-b40d-6796219adc1f
Call-ID: 2bebabe1-764f-43e1-9303-5a713620cbfe
CSeq: 21026 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.1.0.0 build 437
To: <sip:6094055@192.168.145.40>;tag=9d4e9f080d0cbcf0
Content-Length: 0

12:12:47 422062987mS Sip: c0a80205000007e5 17.2021.1 -1 SIPTrunk Endpoint(f17bafec) Present Call, no match (6094055) from URI in To header or (6094055) from request URI
12:12:47 422062988mS SIP Call Tx: 17
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPjbd507d70-b4f0-4557-be62-ea8ae36dbe94
From: "18683555315" <sip:18683555315@192.168.200.173>;tag=982b1d59-35ea-4780-b40d-6796219adc1f
Call-ID: 2bebabe1-764f-43e1-9303-5a713620cbfe
CSeq: 21026 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.1.0.0 build 437
Reason: Q.850;cause=1;text="Unallocated (unassigned) number"
To: <sip:6094055@192.168.145.40>;tag=9d4e9f080d0cbcf0
Content-Length: 0

12:12:47 422062989mS SIP Tx: UDP 192.168.145.40:5060 -> 172.29.0.5:5060
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPjbd507d70-b4f0-4557-be62-ea8ae36dbe94
From: "18683555315" <sip:18683555315@192.168.200.173>;tag=982b1d59-35ea-4780-b40d-6796219adc1f
Call-ID: 2bebabe1-764f-43e1-9303-5a713620cbfe
CSeq: 21026 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.1.0.0 build 437
Reason: Q.850;cause=1;text="Unallocated (unassigned) number"
To: <sip:6094055@192.168.145.40>;tag=9d4e9f080d0cbcf0
Content-Length: 0

12:12:47 422062993mS SIP Rx: UDP 172.29.0.5:5060 -> 192.168.145.40:5060
ACK sip:6094055@192.168.145.40 SIP/2.0
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPjbd507d70-b4f0-4557-be62-ea8ae36dbe94
From: "18683555315" <sip:18683555315@192.168.200.173>;tag=982b1d59-35ea-4780-b40d-6796219adc1f
To: <sip:6094055@192.168.145.40>;tag=9d4e9f080d0cbcf0
Call-ID: 2bebabe1-764f-43e1-9303-5a713620cbfe
CSeq: 21026 ACK
Max-Forwards: 70
User-Agent: FPBX-15.0.17.62(16.17.0)
Content-Length: 0

12:12:47 422062995mS SIP Call Rx: 17
ACK sip:6094055@192.168.145.40 SIP/2.0
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPjbd507d70-b4f0-4557-be62-ea8ae36dbe94
From: "18683555315" <sip:18683555315@192.168.200.173>;tag=982b1d59-35ea-4780-b40d-6796219adc1f
To: <sip:6094055@192.168.145.40>;tag=9d4e9f080d0cbcf0
Call-ID: 2bebabe1-764f-43e1-9303-5a713620cbfe
CSeq: 21026 ACK
Max-Forwards: 70
User-Agent: FPBX-15.0.17.62(16.17.0)
Content-Length: 0

12:12:48 422063995mS Sip: SIPDialog f17bafec deleted, dialogs 0
12:12:50 422065892mS RES: Mon 15/11/2021 12:12:50 FreeMem=55556436 (Heap=55239812(4) + Cache=316624) MemObjs=11846(Max 12482) CMMsg=4(7) Buff=5200 1350 1000 7444 5 Links=56105(58000) BTree=14178 CPU=11.28% CPUStats=04.78%/1/3/2525/19210/20019/00.00%/0/0
2.49% MCR=0 MCW=0
12:12:50 422065893mS RES2: IP 500 V2 9.1.0.0 build 437 Tasks=56 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=68 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=1 TCP=23(TLS=3) TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
12:12:50 422065893mS RES4: XML MemObjs=63 PoolMem=4876404(2) FreeMem=4861100(0)
12:12:50 422065893mS RES5: CLog MemObjs=345 FreePoolMem(Objs)=8060(155) TotalMem=129600
12:12:55 422071829mS SIP Rx: UDP 172.29.0.5:5060 -> 192.168.145.40:5060
OPTIONS sip:192.168.145.40 SIP/2.0
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPj8675395b-3665-4ad4-a65e-596eaf9d6b24
From: <sip:Amaranth_SeaLots_4055_Trunk@192.168.200.173>;tag=e0dd8dbf-f645-49a7-bf87-12bd1b87e7cf
To: <sip:192.168.145.40>
Contact: <sip:Amaranth_SeaLots_4055_Trunk@172.29.0.5:5060>
Call-ID: d4cee443-cf70-4c63-96ee-1ae7caab76ad
CSeq: 7084 OPTIONS
Max-Forwards: 70
User-Agent: FPBX-15.0.17.62(16.17.0)
Content-Length: 0

12:12:55 422071831mS SIP Reg/Opt Rx: 17
OPTIONS sip:192.168.145.40 SIP/2.0
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPj8675395b-3665-4ad4-a65e-596eaf9d6b24
From: <sip:Amaranth_SeaLots_4055_Trunk@192.168.200.173>;tag=e0dd8dbf-f645-49a7-bf87-12bd1b87e7cf
To: <sip:192.168.145.40>
Contact: <sip:Amaranth_SeaLots_4055_Trunk@172.29.0.5:5060>
Call-ID: d4cee443-cf70-4c63-96ee-1ae7caab76ad
CSeq: 7084 OPTIONS
Max-Forwards: 70
User-Agent: FPBX-15.0.17.62(16.17.0)
Content-Length: 0

12:12:55 422071831mS Sip: SIPDialog f4f213a8 created, dialogs 1
12:12:55 422071833mS SIP Reg/Opt Tx: 17
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPj8675395b-3665-4ad4-a65e-596eaf9d6b24
From: <sip:Amaranth_SeaLots_4055_Trunk@192.168.200.173>;tag=e0dd8dbf-f645-49a7-bf87-12bd1b87e7cf
Call-ID: d4cee443-cf70-4c63-96ee-1ae7caab76ad
CSeq: 7084 OPTIONS
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.1.0.0 build 437
To: <sip:192.168.145.40>;tag=fc2478974034fa73
Content-Type: application/sdp
Content-Length: 232

v=0
o=UserA 743688102 2900118560 IN IP4 0.0.0.0
s=Session SDP
c=IN IP4 0.0.0.0
t=0 0
m=audio 8000 RTP/AVP 18 8 0 4
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:4 G723/16000
12:12:55 422071833mS SIP Tx: UDP 192.168.145.40:5060 -> 172.29.0.5:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPj8675395b-3665-4ad4-a65e-596eaf9d6b24
From: <sip:Amaranth_SeaLots_4055_Trunk@192.168.200.173>;tag=e0dd8dbf-f645-49a7-bf87-12bd1b87e7cf
Call-ID: d4cee443-cf70-4c63-96ee-1ae7caab76ad
CSeq: 7084 OPTIONS
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.1.0.0 build 437
To: <sip:192.168.145.40>;tag=fc2478974034fa73
Content-Type: application/sdp
Content-Length: 232

v=0
o=UserA 743688102 2900118560 IN IP4 0.0.0.0
s=Session SDP
c=IN IP4 0.0.0.0
t=0 0
m=audio 8000 RTP/AVP 18 8 0 4
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:4 G723/16000
12:12:55 422071893mS RES: Mon 15/11/2021 12:12:55 FreeMem=55548428 (Heap=55240372(3) + Cache=308056) MemObjs=11883(Max 12482) CMMsg=4(7) Buff=5200 1350 1000 7442 5 Links=56107(58000) BTree=14178 CPU=09.64% CPUStats=03.35%/1/3/2525/19310/20019/00.01%/1/0
2.49% MCR=0 MCW=0
12:12:55 422071893mS RES2: IP 500 V2 9.1.0.0 build 437 Tasks=56 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=68 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=1 TCP=23(TLS=3) TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
12:12:55 422071893mS RES4: XML MemObjs=63 PoolMem=4876404(2) FreeMem=4861100(0)
12:12:55 422071893mS RES5: CLog MemObjs=345 FreePoolMem(Objs)=8060(155) TotalMem=129600
12:13:00 422076834mS Sip: SIPDialog f4f213a8 deleted, dialogs 0
12:13:00 422076895mS RES: Mon 15/11/2021 12:13:01 FreeMem=55593864 (Heap=55273160(3) + Cache=320704) MemObjs=11745(Max 12482) CMMsg=4(7) Buff=5200 1350 1000 7444 5 Links=56103(58000) BTree=14178 CPU=08.00% CPUStats=03.04%/1/3/2525/19543/20019/00.01%/1/0
2.49% MCR=0 MCW=0
12:13:00 422076896mS RES2: IP 500 V2 9.1.0.0 build 437 Tasks=56 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=67 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=1 TCP=23(TLS=3) TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
12:13:00 422076896mS RES4: XML MemObjs=63 PoolMem=4876404(2) FreeMem=4861100(0)
12:13:00 422076896mS RES5: CLog MemObjs=345 FreePoolMem(Objs)=8060(155) TotalMem=129600

********** Warning: Logging to Screen Stopped **********

 

[j_redhead]

 

[j_redhead]

 

[j_redhead]

 

[j_redhead]

 

[j_redhead]

This is what was sent by the service provider

 

[critchey]

12:12:47 422062989mS SIP Tx: UDP 192.168.145.40:5060 -> 172.29.0.5:5060
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.29.0.5:5060;rport;branch=z9hG4bKPjbd507d70-b4f0-4557-be62-ea8ae36dbe94
From: "18683555315" <sip:18683555315@192.168.200.173>;tag=982b1d59-35ea-4780-b40d-6796219adc1f
Call-ID: 2bebabe1-764f-43e1-9303-5a713620cbfe
CSeq: 21026 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.1.0.0 build 437
Reason: Q.850;cause=1;text="Unallocated (unassigned) number"
To: <sip:6094055@192.168.145.40>;tag=9d4e9f080d0cbcf0
Content-Length: 0

Sounds like an incoming call route issue. How is your incoming call route setup for this DID?

The truth is just an excuse for lack of imagination.

 

[sizbut]

Agree, the trace shows the system has got the call and then gone 404 - no match to the number. You need a default ICR to catch anything coming in on incoming group 11 and at least send it to a default extension or group.

Stuck in a never ending cycle of file copying.

 

[j_redhead]

Incoming call route is configured as follows in the picture

 

[snowman50]

So your line is built against 17
Your groups are 0 ,11
Your outgoing ACR route is 11

Your INCOMING ICR routes Are 10,0
0 has no incoming NUMBER. ??
But 10 has an incoming number ??

So if incoming is group 0 put the number there.

 

[critchey]

Go to the standard tab for the no CLI incoming call route. What is the bearer capability set too? Im guessing you altered the default incoming call routes and that was the modem route which means the bearer capability is wrong.

The truth is just an excuse for lack of imagination.