fresh install of fusionpbx on debian 10, fusionpbx from install script. Inbound calls are always rejected. outbound calls ok.
It seems that the call connects, but when fuisionpbx is asked for a proxy auth, it responds with an ack rather than an invite and the call is terminated. How do I fix it?
dialplan is plain vanilla
<extension name="025301xxxx" continue="false" uuid="1762bfb8-ed77-4df3-831e-ae84d1f56d64">
<condition field="destination_number" expression="^(025301xxxx)$">
<action application="export" data="call_direction=inbound" inline="true"/>
<action application="set" data="domain_uuid=4fa6be9f-0aa6-447e-aec0-9a1fc7712fa5" inline="true"/>
<action application="set" data="domain_name=150.101.193.30" inline="true"/>
<action application="set" data="hangup_after_bridge=true"/>
<action application="set" data="continue_on_fail=true"/>
<action application="transfer" data="211 XML 150.101.193.30"/>
</condition>
</extension>
SIP trace:
recv 1005 bytes from udp/[203.2.134.1]:5060 at 11:59:33.433147:
------------------------------------------------------------------------
INVITE sip:gw+b1ec8787-ff02-40f2-9d43-3e100bdf058a@150.101.193.30:5060;transport=udp;gw=b1ec8787-ff02-40f2-9d43-3e100bdf058a SIP/2.0
Via: SIP/2.0/UDP 203.2.134.1:5060;branch=z9hG4bKrbf22u208g1lcadvi400.1
From: <sip:042860xxxx@203.2.134.130;user=phone>;tag=775167426-1566698373392-
To: "NodePhone"<sip:025301xxxx@sip.internode.on.net;gw=b1ec8787-ff02-40f2-9d43-3e100bdf058a>
Call-ID: BW015933392250819-717089151@203.2.134.130
CSeq: 591397001 INVITE
Contact: <sip:042860xxxx@203.2.134.1:5060;transport=udp>
Supported: 100rel
Allow: ACK,BYE,CANCEL,INFO,INVITE,OPTIONS,PRACK,REFER,NOTIFY
Recv-Info: x-broadworks-client-session-info
Accept: application/media_control+xml,application/sdp,multipart/mixed
Max-Forwards: 69
Content-Type: application/sdp
Content-Length: 224
v=0
o=BroadWorks 66599 1 IN IP4 203.2.134.1
s=-
c=IN IP4 203.2.134.1
t=0 0
m=audio 16640 RTP/AVP 8 0 18 106 101
a=rtpmap:106 G.729b/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=bsoft: 1 image udptl t38
2019-08-25 11:59:33.426293 [NOTICE] switch_channel.c:1118 New Channel sofia/external/042860xxxx@203.2.134.130 [6cb952d0-de5a-4e6b-85cf-7d17076ae6c7]
2019-08-25 11:59:33.426293 [DEBUG] switch_core_state_machine.c:585 (sofia/external/042860xxxx@203.2.134.130) Running State Change CS_NEW (Cur 2 Tot 4)
2019-08-25 11:59:33.426293 [DEBUG] sofia.c:10243 sofia/external/042860xxxx@203.2.134.130 receiving invite from 203.2.134.1:5060 version: 1.10.1 -release-12-f9990221e6 64bit
2019-08-25 11:59:33.426293 [DEBUG] sofia.c:10337 verifying acl "domains" for ip/port 203.2.134.1:0.
2019-08-25 11:59:33.426293 [DEBUG] switch_core_state_machine.c:604 (sofia/external/042860xxxx@203.2.134.130) State NEW
send 751 bytes to udp/[203.2.134.1]:5060 at 11:59:33.439294:
------------------------------------------------------------------------
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP 203.2.134.1:5060;branch=z9hG4bKrbf22u208g1lcadvi400.1
From: <sip:042860xxxx@203.2.134.130;user=phone>;tag=775167426-1566698373392-
To: "NodePhone" <sip:025301xxxx@sip.internode.on.net;gw=b1ec8787-ff02-40f2-9d43-3e100bdf058a>;tag=ZgDBp4ZN15NKB
Call-ID: BW015933392250819-717089151@203.2.134.130
CSeq: 591397001 INVITE
User-Agent: FreeSWITCH
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, refer
Proxy-Authenticate: Digest realm="sip.internode.on.net", nonce="9903ed54-1b5b-4db6-8723-734b9d078c89", algorithm=MD5, qop="auth"
Content-Length: 0
2019-08-25 11:59:33.426293 [DEBUG] sofia.c:2426 detaching session 6cb952d0-de5a-4e6b-85cf-7d17076ae6c7
recv 505 bytes from udp/[203.2.134.1]:5060 at 11:59:33.514048:
------------------------------------------------------------------------
ACK sip:gw+b1ec8787-ff02-40f2-9d43-3e100bdf058a@150.101.193.30:5060;transport=udp;gw=b1ec8787-ff02-40f2-9d43-3e100bdf058a SIP/2.0
Via: SIP/2.0/UDP 203.2.134.1:5060;branch=z9hG4bKrbf22u208g1lcadvi400.1
CSeq: 591397001 ACK
From: <sip:042860xxxx@203.2.134.130;user=phone>;tag=775167426-1566698373392-
To: "NodePhone"<sip:025301xxxx@sip.internode.on.net;gw=b1ec8787-ff02-40f2-9d43-3e100bdf058a>;tag=ZgDBp4ZN15NKB
Call-ID: BW015933392250819-717089151@203.2.134.130
Max-Forwards: 69
Content-Length: 0
2019-08-25 11:59:43.446493 [WARNING] switch_core_state_machine.c:688 f2235033-8716-4b98-a985-37e972e01983 sofia/external/042860xxxx@203.2.134.129 Abandoned
2019-08-25 11:59:43.446493 [NOTICE] switch_core_state_machine.c:691 Hangup sofia/external/042860xxxx@203.2.134.129 [CS_NEW] [WRONG_CALL_STATE]
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:585 (sofia/external/042860xxxx@203.2.134.129) Running State Change CS_HANGUP (Cur 2 Tot 4)
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:848 (sofia/external/042860xxxx@203.2.134.129) Callstate Change DOWN -> HANGUP
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:850 (sofia/external/042860xxxx@203.2.134.129) State HANGUP
2019-08-25 11:59:43.446493 [DEBUG] mod_sofia.c:460 Channel sofia/external/042860xxxx@203.2.134.129 hanging up, cause: WRONG_CALL_STATE
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:60 sofia/external/042860xxxx@203.2.134.129 Standard HANGUP, cause: WRONG_CALL_STATE
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:850 (sofia/external/042860xxxx@203.2.134.129) State HANGUP going to sleep
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:620 (sofia/external/042860xxxx@203.2.134.129) State Change CS_HANGUP -> CS_REPORTING
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:585 (sofia/external/042860xxxx@203.2.134.129) Running State Change CS_REPORTING (Cur 2 Tot 4)
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:936 (sofia/external/042860xxxx@203.2.134.129) State REPORTING
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:174 sofia/external/042860xxxx@203.2.134.129 Standard REPORTING, cause: WRONG_CALL_STATE
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:936 (sofia/external/042860xxxx@203.2.134.129) State REPORTING going to sleep
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:611 (sofia/external/042860xxxx@203.2.134.129) State Change CS_REPORTING -> CS_DESTROY
2019-08-25 11:59:43.446493 [DEBUG] switch_core_session.c:1726 Session 3 (sofia/external/042860xxxx@203.2.134.129) Locked, Waiting on external entities
2019-08-25 11:59:43.446493 [NOTICE] switch_core_session.c:1744 Session 3 (sofia/external/042860xxxx@203.2.134.129) Ended
2019-08-25 11:59:43.446493 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/042860xxxx@203.2.134.129 [CS_DESTROY]
It seems that the call connects, but when fuisionpbx is asked for a proxy auth, it responds with an ack rather than an invite and the call is terminated. How do I fix it?
dialplan is plain vanilla
<extension name="025301xxxx" continue="false" uuid="1762bfb8-ed77-4df3-831e-ae84d1f56d64">
<condition field="destination_number" expression="^(025301xxxx)$">
<action application="export" data="call_direction=inbound" inline="true"/>
<action application="set" data="domain_uuid=4fa6be9f-0aa6-447e-aec0-9a1fc7712fa5" inline="true"/>
<action application="set" data="domain_name=150.101.193.30" inline="true"/>
<action application="set" data="hangup_after_bridge=true"/>
<action application="set" data="continue_on_fail=true"/>
<action application="transfer" data="211 XML 150.101.193.30"/>
</condition>
</extension>
SIP trace:
recv 1005 bytes from udp/[203.2.134.1]:5060 at 11:59:33.433147:
------------------------------------------------------------------------
INVITE sip:gw+b1ec8787-ff02-40f2-9d43-3e100bdf058a@150.101.193.30:5060;transport=udp;gw=b1ec8787-ff02-40f2-9d43-3e100bdf058a SIP/2.0
Via: SIP/2.0/UDP 203.2.134.1:5060;branch=z9hG4bKrbf22u208g1lcadvi400.1
From: <sip:042860xxxx@203.2.134.130;user=phone>;tag=775167426-1566698373392-
To: "NodePhone"<sip:025301xxxx@sip.internode.on.net;gw=b1ec8787-ff02-40f2-9d43-3e100bdf058a>
Call-ID: BW015933392250819-717089151@203.2.134.130
CSeq: 591397001 INVITE
Contact: <sip:042860xxxx@203.2.134.1:5060;transport=udp>
Supported: 100rel
Allow: ACK,BYE,CANCEL,INFO,INVITE,OPTIONS,PRACK,REFER,NOTIFY
Recv-Info: x-broadworks-client-session-info
Accept: application/media_control+xml,application/sdp,multipart/mixed
Max-Forwards: 69
Content-Type: application/sdp
Content-Length: 224
v=0
o=BroadWorks 66599 1 IN IP4 203.2.134.1
s=-
c=IN IP4 203.2.134.1
t=0 0
m=audio 16640 RTP/AVP 8 0 18 106 101
a=rtpmap:106 G.729b/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=bsoft: 1 image udptl t38
2019-08-25 11:59:33.426293 [NOTICE] switch_channel.c:1118 New Channel sofia/external/042860xxxx@203.2.134.130 [6cb952d0-de5a-4e6b-85cf-7d17076ae6c7]
2019-08-25 11:59:33.426293 [DEBUG] switch_core_state_machine.c:585 (sofia/external/042860xxxx@203.2.134.130) Running State Change CS_NEW (Cur 2 Tot 4)
2019-08-25 11:59:33.426293 [DEBUG] sofia.c:10243 sofia/external/042860xxxx@203.2.134.130 receiving invite from 203.2.134.1:5060 version: 1.10.1 -release-12-f9990221e6 64bit
2019-08-25 11:59:33.426293 [DEBUG] sofia.c:10337 verifying acl "domains" for ip/port 203.2.134.1:0.
2019-08-25 11:59:33.426293 [DEBUG] switch_core_state_machine.c:604 (sofia/external/042860xxxx@203.2.134.130) State NEW
send 751 bytes to udp/[203.2.134.1]:5060 at 11:59:33.439294:
------------------------------------------------------------------------
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP 203.2.134.1:5060;branch=z9hG4bKrbf22u208g1lcadvi400.1
From: <sip:042860xxxx@203.2.134.130;user=phone>;tag=775167426-1566698373392-
To: "NodePhone" <sip:025301xxxx@sip.internode.on.net;gw=b1ec8787-ff02-40f2-9d43-3e100bdf058a>;tag=ZgDBp4ZN15NKB
Call-ID: BW015933392250819-717089151@203.2.134.130
CSeq: 591397001 INVITE
User-Agent: FreeSWITCH
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, refer
Proxy-Authenticate: Digest realm="sip.internode.on.net", nonce="9903ed54-1b5b-4db6-8723-734b9d078c89", algorithm=MD5, qop="auth"
Content-Length: 0
2019-08-25 11:59:33.426293 [DEBUG] sofia.c:2426 detaching session 6cb952d0-de5a-4e6b-85cf-7d17076ae6c7
recv 505 bytes from udp/[203.2.134.1]:5060 at 11:59:33.514048:
------------------------------------------------------------------------
ACK sip:gw+b1ec8787-ff02-40f2-9d43-3e100bdf058a@150.101.193.30:5060;transport=udp;gw=b1ec8787-ff02-40f2-9d43-3e100bdf058a SIP/2.0
Via: SIP/2.0/UDP 203.2.134.1:5060;branch=z9hG4bKrbf22u208g1lcadvi400.1
CSeq: 591397001 ACK
From: <sip:042860xxxx@203.2.134.130;user=phone>;tag=775167426-1566698373392-
To: "NodePhone"<sip:025301xxxx@sip.internode.on.net;gw=b1ec8787-ff02-40f2-9d43-3e100bdf058a>;tag=ZgDBp4ZN15NKB
Call-ID: BW015933392250819-717089151@203.2.134.130
Max-Forwards: 69
Content-Length: 0
2019-08-25 11:59:43.446493 [WARNING] switch_core_state_machine.c:688 f2235033-8716-4b98-a985-37e972e01983 sofia/external/042860xxxx@203.2.134.129 Abandoned
2019-08-25 11:59:43.446493 [NOTICE] switch_core_state_machine.c:691 Hangup sofia/external/042860xxxx@203.2.134.129 [CS_NEW] [WRONG_CALL_STATE]
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:585 (sofia/external/042860xxxx@203.2.134.129) Running State Change CS_HANGUP (Cur 2 Tot 4)
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:848 (sofia/external/042860xxxx@203.2.134.129) Callstate Change DOWN -> HANGUP
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:850 (sofia/external/042860xxxx@203.2.134.129) State HANGUP
2019-08-25 11:59:43.446493 [DEBUG] mod_sofia.c:460 Channel sofia/external/042860xxxx@203.2.134.129 hanging up, cause: WRONG_CALL_STATE
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:60 sofia/external/042860xxxx@203.2.134.129 Standard HANGUP, cause: WRONG_CALL_STATE
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:850 (sofia/external/042860xxxx@203.2.134.129) State HANGUP going to sleep
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:620 (sofia/external/042860xxxx@203.2.134.129) State Change CS_HANGUP -> CS_REPORTING
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:585 (sofia/external/042860xxxx@203.2.134.129) Running State Change CS_REPORTING (Cur 2 Tot 4)
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:936 (sofia/external/042860xxxx@203.2.134.129) State REPORTING
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:174 sofia/external/042860xxxx@203.2.134.129 Standard REPORTING, cause: WRONG_CALL_STATE
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:936 (sofia/external/042860xxxx@203.2.134.129) State REPORTING going to sleep
2019-08-25 11:59:43.446493 [DEBUG] switch_core_state_machine.c:611 (sofia/external/042860xxxx@203.2.134.129) State Change CS_REPORTING -> CS_DESTROY
2019-08-25 11:59:43.446493 [DEBUG] switch_core_session.c:1726 Session 3 (sofia/external/042860xxxx@203.2.134.129) Locked, Waiting on external entities
2019-08-25 11:59:43.446493 [NOTICE] switch_core_session.c:1744 Session 3 (sofia/external/042860xxxx@203.2.134.129) Ended
2019-08-25 11:59:43.446493 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/042860xxxx@203.2.134.129 [CS_DESTROY]