Can't make outgoing calls or internal extension to extension calls

Status
Not open for further replies.
M

mmonday88

New Member
Nov 3, 2020
2
0
1
35
Hello,

I am having an issue where I cannot make outgoing calls or call internal from extension to extension.

This is a fresh installation where I have added the extensions, gateway, destination/inbound routes, outbound routes, and added my flowroute IPs to my domain ACL (although I am not sure I typed in the ranges properly because I cant receive calls if i set the default action to deny and only allow those ips. For now, I have it set to allow temporarily and I can receive calls to my main IVR.)

Here is the log from my internal extension to extension call:

Code: 
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.122980 [INFO] mod_dialplan_xml.c:637 Processing Matthew Monday <1006>->1005 in context public
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 parsing [public->caller-details] continue=true
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 Regex (PASS) [caller-details] () =~ // break=never
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 Action export(call_direction=inbound) INLINE
76027a8b-ade2-49d0-8330-847f7896770f EXECUTE [depth=0] sofia/internal/1006@192.168.1.5:5060 export(call_direction=inbound)
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.122980 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_direction]=[inbound]
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 Action set(caller_destination=${sip_to_user}) INLINE
76027a8b-ade2-49d0-8330-847f7896770f EXECUTE [depth=0] sofia/internal/1006@192.168.1.5:5060 set(caller_destination=1005)
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.122980 [DEBUG] mod_dptools.c:1672 SET sofia/internal/1006@192.168.1.5:5060 [caller_destination]=[1005]
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 Action set(caller_id_name=${caller_id_name}) INLINE
76027a8b-ade2-49d0-8330-847f7896770f EXECUTE [depth=0] sofia/internal/1006@192.168.1.5:5060 set(caller_id_name=Matthew Monday)
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.122980 [DEBUG] mod_dptools.c:1672 SET sofia/internal/1006@192.168.1.5:5060 [caller_id_name]=[Matthew Monday]
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 Action set(caller_id_number=${caller_id_number})
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 parsing [public->2512430043] continue=false
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 Regex (FAIL) [2512430043] destination_number(1005) =~ /^\+?1?(2512430043)$/ break=on-false
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 parsing [public->not-found] continue=false
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 Regex (PASS) [not-found] () =~ // break=on-false
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 Action export(call_direction=inbound) INLINE
76027a8b-ade2-49d0-8330-847f7896770f EXECUTE [depth=0] sofia/internal/1006@192.168.1.5:5060 export(call_direction=inbound)
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.122980 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_direction]=[inbound]
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 Action set(call_direction=inbound) INLINE
76027a8b-ade2-49d0-8330-847f7896770f EXECUTE [depth=0] sofia/internal/1006@192.168.1.5:5060 set(call_direction=inbound)
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.122980 [DEBUG] mod_dptools.c:1672 SET sofia/internal/1006@192.168.1.5:5060 [call_direction]=[inbound]
76027a8b-ade2-49d0-8330-847f7896770f Dialplan: sofia/internal/1006@192.168.1.5:5060 Action log(WARNING [inbound routes] 404 not found ${sip_network_ip})
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:287 (sofia/internal/1006@192.168.1.5:5060) State Change CS_ROUTING -> CS_EXECUTE
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:644 (sofia/internal/1006@192.168.1.5:5060) State ROUTING going to sleep
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/1006@192.168.1.5:5060) Running State Change CS_EXECUTE (Cur 3 Tot 18)
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:651 (sofia/internal/1006@192.168.1.5:5060) State EXECUTE
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] mod_sofia.c:209 sofia/internal/1006@192.168.1.5:5060 SOFIA EXECUTE
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:329 sofia/internal/1006@192.168.1.5:5060 Standard EXECUTE
76027a8b-ade2-49d0-8330-847f7896770f EXECUTE [depth=0] sofia/internal/1006@192.168.1.5:5060 set(caller_id_number=1006)
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] mod_dptools.c:1672 SET sofia/internal/1006@192.168.1.5:5060 [caller_id_number]=[1006]
76027a8b-ade2-49d0-8330-847f7896770f EXECUTE [depth=0] sofia/internal/1006@192.168.1.5:5060 log(WARNING [inbound routes] 404 not found 192.168.1.166)
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [WARNING] mod_dptools.c:1866 [inbound routes] 404 not found 192.168.1.166
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [NOTICE] switch_core_state_machine.c:386 sofia/internal/1006@192.168.1.5:5060 has executed the last dialplan instruction, hanging up.
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [NOTICE] switch_core_state_machine.c:388 Hangup sofia/internal/1006@192.168.1.5:5060 [CS_EXECUTE] [NORMAL_CLEARING]
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:651 (sofia/internal/1006@192.168.1.5:5060) State EXECUTE going to sleep
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/1006@192.168.1.5:5060) Running State Change CS_HANGUP (Cur 3 Tot 18)
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:848 (sofia/internal/1006@192.168.1.5:5060) Callstate Change RINGING -> HANGUP
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1006@192.168.1.5:5060) State HANGUP
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] mod_sofia.c:453 Channel sofia/internal/1006@192.168.1.5:5060 hanging up, cause: NORMAL_CLEARING
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] mod_sofia.c:598 Responding to INVITE with: 480
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1006@192.168.1.5:5060 Standard HANGUP, cause: NORMAL_CLEARING
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1006@192.168.1.5:5060) State HANGUP going to sleep
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:620 (sofia/internal/1006@192.168.1.5:5060) State Change CS_HANGUP -> CS_REPORTING
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/1006@192.168.1.5:5060) Running State Change CS_REPORTING (Cur 3 Tot 18)
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.142981 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/1006@192.168.1.5:5060) State REPORTING
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.162979 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1006@192.168.1.5:5060 Standard REPORTING, cause: NORMAL_CLEARING
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.162979 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/1006@192.168.1.5:5060) State REPORTING going to sleep
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.162979 [DEBUG] switch_core_state_machine.c:611 (sofia/internal/1006@192.168.1.5:5060) State Change CS_REPORTING -> CS_DESTROY
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.162979 [DEBUG] switch_core_session.c:1726 Session 18 (sofia/internal/1006@192.168.1.5:5060) Locked, Waiting on external entities
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.162979 [NOTICE] switch_core_session.c:1744 Session 18 (sofia/internal/1006@192.168.1.5:5060) Ended
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.162979 [NOTICE] switch_core_session.c:1748 Close Channel sofia/internal/1006@192.168.1.5:5060 [CS_DESTROY]
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.162979 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/1006@192.168.1.5:5060) Running State Change CS_DESTROY (Cur 2 Tot 18)
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.162979 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/1006@192.168.1.5:5060) State DESTROY
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.162979 [DEBUG] mod_sofia.c:364 sofia/internal/1006@192.168.1.5:5060 SOFIA DESTROY
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.162979 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1006@192.168.1.5:5060 Standard DESTROY
76027a8b-ade2-49d0-8330-847f7896770f 2020-11-05 08:34:54.162979 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/1006@192.168.1.5:5060) State DESTROY going to sleep

I had this issue yesterday on another install, so I recreated the Virtual machine from scratch with a fresh installation of fusion pbx on debian.

I am just looking to get extension to extension working properly first, then I can see whether the outbound is still an issue.

Any insight would be much appreciated. I can provide any other information that may be needed.
 

Attachments

  • sipstatus.PNG
    sipstatus.PNG
    22.8 KB · Views: 14
  • acls.PNG
    acls.PNG
    26.8 KB · Views: 14
  • outbound.PNG
    outbound.PNG
    19.5 KB · Views: 13
  • extensions.PNG
    extensions.PNG
    54.1 KB · Views: 10
  • registrations.PNG
    registrations.PNG
    58.8 KB · Views: 11
DigitalDaz

DigitalDaz

Administrator
Staff member
Sep 29, 2016
3,045
566
113
Without looking at anything other than the call log I see you are in the public context, this usually means you have added something to the ACL that you shouldn't have. You should only be touching the ACL to add carriers.
 
M

mmonday88

New Member
Nov 3, 2020
2
0
1
35
Thanks. You are correct.

I have this working now, and my mistake was changing the default action of the domains ACL to allow.

In the docs, it clearly says don't do this (DOH!). I changed it to allow because I wasnt getting incoming calls.

I was adding the IPs from Flowroute back in here one at a time instead of in a range which I didnt get working.

Is it possible to enter a range of IPs in the ACL?

My flowroute uses a block of 17 IPs, and in the event of that block being down may failover to another block of 17.

Do I have to enter all 34 IPs as single entries in the ACL as xx.xx.xx.xx/32 or can I do a range?

I entered in the 17 for my primary in this /32 format for the CIDR and reset the default action to deny.

All worked normally after that.
 
Status
Not open for further replies.
Top Bottom