Outgoing Calls - All Circuits are busy, Incoming OK - Logs Included

Hi Guys First post here as after trying to sort this issue out for a few weeks now and have exhausted all I can find on google and other forums I have turned here for help.

I can receive calls fine through my SIP trunk so that side is working OK.

I cannot dial out though… I have created an outbound dialing rule of just “.” and tried combinations of “X.” etc with no dice.

I am using “Zoiper” soft phone app on my PC to test this before I put any hardware into place.

I have configured this rule with a password which gives me time to turn debugging on, enter my password and record the logs.

Here are the logs below, I cant make heads or tails of the log to find where it is going wrong…

SIP Debugging enabled

<— SIP read from UDP:192.168.1.104:61663 —>

<------------->

<— SIP read from UDP:192.168.1.104:61663 —>
INVITE sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-e514ff6d431c49e6-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP
From: sip:[email protected];transport=UDP;tag=5678ab0d
Call-ID: YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.
CSeq: 1 INVITE
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/sdp
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Allow-Events: presence, kpml
Content-Length: 241

v=0
o=Z 0 0 IN IP4 192.168.1.104
s=Z
c=IN IP4 192.168.1.104
t=0 0
m=audio 8000 RTP/AVP 3 110 8 0 98 101
a=rtpmap:110 speex/8000
a=rtpmap:98 iLBC/8000
a=fmtp:98 mode=20
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
<------------->
— (14 headers 12 lines) —
Sending to 192.168.1.104:61663 (NAT)
Sending to 192.168.1.104:61663 (NAT)
Using INVITE request as basis request - YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.
Found peer ‘200’ for ‘200’ from 192.168.1.104:61663

<— Reliably Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-e514ff6d431c49e6-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=5678ab0d
To: sip:[email protected];transport=UDP;tag=as0b87e703
Call-ID: YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.
CSeq: 1 INVITE
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce="65f3cf5a"
Content-Length: 0

<------------>
Scheduling destruction of SIP dialog ‘YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.’ in 6400 ms (Method: INVITE)

<— SIP read from UDP:192.168.1.104:61663 —>
PUBLISH sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-f69e89c399023e7f-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP
From: sip:[email protected];transport=UDP;tag=b009e23e
Call-ID: YmY3ODE1MjM5ODM0NTYwNTVjODc3YjM2NThhM2VmMjU.
CSeq: 1 PUBLISH
Expires: 600
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/pidf+xml
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence
Allow-Events: presence, kpml
Content-Length: 265

<?xml version="1.0" encoding="UTF-8"?>

open On the phone

<------------->
— (16 headers 3 lines) —
Sending to 192.168.1.104:61663 (NAT)

<— Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-f69e89c399023e7f-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=b009e23e
To: sip:[email protected]177;transport=UDP;tag=as161de69c
Call-ID: YmY3ODE1MjM5ODM0NTYwNTVjODc3YjM2NThhM2VmMjU.
CSeq: 1 PUBLISH
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
Really destroying SIP dialog ‘YmY3ODE1MjM5ODM0NTYwNTVjODc3YjM2NThhM2VmMjU.’ Method: PUBLISH

<— SIP read from UDP:192.168.1.104:61663 —>
SUBSCRIBE sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-8861af1c33b614af-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP
From: sip:[email protected];transport=UDP;tag=b5005041
Call-ID: NDE1OWNiZWM0OGIwOGI1ZDA0NDIwMWRhZTg2ZmZkY2M.
CSeq: 1 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
— (16 headers 0 lines) —
Sending to 192.168.1.104:61663 (NAT)
Creating new subscription
Sending to 192.168.1.104:61663 (NAT)
list_route: hop: sip:[email protected]:61663;transport=UDP
Found peer ‘200’ for ‘200’ from 192.168.1.104:61663

<— Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-8861af1c33b614af-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=b5005041
To: sip:[email protected];transport=UDP;tag=as7df9f38a
Call-ID: NDE1OWNiZWM0OGIwOGI1ZDA0NDIwMWRhZTg2ZmZkY2M.
CSeq: 1 SUBSCRIBE
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce="473943d0"
Content-Length: 0

<------------>
Scheduling destruction of SIP dialog ‘NDE1OWNiZWM0OGIwOGI1ZDA0NDIwMWRhZTg2ZmZkY2M.’ in 6400 ms (Method: SUBSCRIBE)

<— SIP read from UDP:192.168.1.104:61663 —>
ACK sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-e514ff6d431c49e6-1—d8754z-
Max-Forwards: 70
To: sip:[email protected];transport=UDP;tag=as0b87e703
From: sip:[email protected];transport=UDP;tag=5678ab0d
Call-ID: YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.
CSeq: 1 ACK
Content-Length: 0

<------------->
— (8 headers 0 lines) —

<— SIP read from UDP:192.168.1.104:61663 —>
INVITE sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-77e92a8884c7e30b-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP
From: sip:[email protected];transport=UDP;tag=5678ab0d
Call-ID: YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/sdp
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username=“200”,realm=“asterisk”,nonce=“65f3cf5a”,uri="sip:[email protected];transport=UDP",response=“2c543ec3a227c1db48dbe441aff2fc32”,algorithm=MD5
Allow-Events: presence, kpml
Content-Length: 241

v=0
o=Z 0 0 IN IP4 192.168.1.104
s=Z
c=IN IP4 192.168.1.104
t=0 0
m=audio 8000 RTP/AVP 3 110 8 0 98 101
a=rtpmap:110 speex/8000
a=rtpmap:98 iLBC/8000
a=fmtp:98 mode=20
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
<------------->
— (15 headers 12 lines) —
Sending to 192.168.1.104:61663 (NAT)
Using INVITE request as basis request - YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.
Found peer ‘200’ for ‘200’ from 192.168.1.104:61663
Found RTP audio format 3
Found RTP audio format 110
Found RTP audio format 8
Found RTP audio format 0
Found RTP audio format 98
Found RTP audio format 101
Found audio description format speex for ID 110
Found audio description format iLBC for ID 98
Found audio description format telephone-event for ID 101
Capabilities: us - (g723|ulaw|alaw|g726|g722), peer - audio=(gsm|ulaw|alaw|speex|ilbc)/video=(nothing)/text=(nothing), combined - (ulaw|alaw)
Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|)
Peer audio RTP is at port 192.168.1.104:8000
Looking for 0276290535 in from-internal (domain 192.168.1.177)
list_route: hop: sip:[email protected]:61663;transport=UDP

<— Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-77e92a8884c7e30b-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=5678ab0d
To: sip:[email protected];transport=UDP
Call-ID: YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.
CSeq: 2 INVITE
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Session-Expires: 1800;refresher=uas
Contact: sip:[email protected]:5060
Content-Length: 0

<------------>

<— SIP read from UDP:192.168.1.104:61663 —>
SUBSCRIBE sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-509fedcdb4f32f44-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP
From: sip:[email protected];transport=UDP;tag=b5005041
Call-ID: NDE1OWNiZWM0OGIwOGI1ZDA0NDIwMWRhZTg2ZmZkY2M.
CSeq: 2 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username=“200”,realm=“asterisk”,nonce=“473943d0”,uri="sip:[email protected];transport=UDP",response=“cce9484f0f88d458bbd3ac656aed4be7”,algorithm=MD5
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
— (17 headers 0 lines) —
Creating new subscription
Sending to 192.168.1.104:61663 (NAT)
Found peer ‘200’ for ‘200’ from 192.168.1.104:61663

<— Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-509fedcdb4f32f44-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=b5005041
To: sip:[email protected];transport=UDP;tag=as7df9f38a
Call-ID: NDE1OWNiZWM0OGIwOGI1ZDA0NDIwMWRhZTg2ZmZkY2M.
CSeq: 2 SUBSCRIBE
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
Really destroying SIP dialog ‘NDE1OWNiZWM0OGIwOGI1ZDA0NDIwMWRhZTg2ZmZkY2M.’ Method: SUBSCRIBE
Audio is at 14732
Adding codec 100003 (ulaw) to SDP
Adding codec 100004 (alaw) to SDP
Adding non-codec 0x1 (telephone-event) to SDP

<— Reliably Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-77e92a8884c7e30b-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=5678ab0d
To: sip:[email protected];transport=UDP;tag=as7e97cebf
Call-ID: YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.
CSeq: 2 INVITE
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Session-Expires: 1800;refresher=uas
Contact: sip:[email protected]:5060
Content-Type: application/sdp
Require: timer
Content-Length: 261

v=0
o=root 1051019173 1051019173 IN IP4 192.168.1.177
s=Asterisk PBX 11.8.1
c=IN IP4 192.168.1.177
t=0 0
m=audio 14732 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

<------------>

<— SIP read from UDP:192.168.1.104:61663 —>
ACK sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-c19db19f6a9c72d9-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP;tag=as7e97cebf
From: sip:[email protected];transport=UDP;tag=5678ab0d
Call-ID: YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.
CSeq: 2 ACK
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username=“200”,realm=“asterisk”,nonce=“65f3cf5a”,uri="sip:[email protected];transport=UDP",response=“2c543ec3a227c1db48dbe441aff2fc32”,algorithm=MD5
Content-Length: 0

<------------->
— (11 headers 0 lines) —

<— SIP read from UDP:192.168.1.104:61663 —>
PUBLISH sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-f41966c69334b82e-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP
From: sip:[email protected];transport=UDP;tag=0547e938
Call-ID: ZGIyNzQ5ZmRhMmRkMjM3YzQ5NWEzZGU0NDA2YjVlMGM.
CSeq: 1 PUBLISH
Expires: 600
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/pidf+xml
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence
Allow-Events: presence, kpml
Content-Length: 265

<?xml version="1.0" encoding="UTF-8"?>

open On the phone

<------------->
— (16 headers 3 lines) —
Sending to 192.168.1.104:61663 (NAT)

<— Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-f41966c69334b82e-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=0547e938
To: sip:[email protected];transport=UDP;tag=as01771602
Call-ID: ZGIyNzQ5ZmRhMmRkMjM3YzQ5NWEzZGU0NDA2YjVlMGM.
CSeq: 1 PUBLISH
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
Really destroying SIP dialog ‘ZGIyNzQ5ZmRhMmRkMjM3YzQ5NWEzZGU0NDA2YjVlMGM.’ Method: PUBLISH

<— SIP read from UDP:192.168.1.104:61663 —>
SUBSCRIBE sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-57ee0722fd575b76-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP
From: sip:[email protected];transport=UDP;tag=7d58916f
Call-ID: MjRhM2UwNDA1Y2Q2YjU5MzAwYWEyZjFiY2RiMTk0MjI.
CSeq: 1 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
— (16 headers 0 lines) —
Sending to 192.168.1.104:61663 (NAT)
Creating new subscription
Sending to 192.168.1.104:61663 (NAT)
list_route: hop: sip:[email protected]:61663;transport=UDP
Found peer ‘200’ for ‘200’ from 192.168.1.104:61663

<— Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-57ee0722fd575b76-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=7d58916f
To: sip:[email protected];transport=UDP;tag=as7558b1df
Call-ID: MjRhM2UwNDA1Y2Q2YjU5MzAwYWEyZjFiY2RiMTk0MjI.
CSeq: 1 SUBSCRIBE
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce="423b749f"
Content-Length: 0

<------------>
Scheduling destruction of SIP dialog ‘MjRhM2UwNDA1Y2Q2YjU5MzAwYWEyZjFiY2RiMTk0MjI.’ in 6400 ms (Method: SUBSCRIBE)

<— SIP read from UDP:192.168.1.104:61663 —>
SUBSCRIBE sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-85b7898ab2d27dee-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP
From: sip:[email protected];transport=UDP;tag=7d58916f
Call-ID: MjRhM2UwNDA1Y2Q2YjU5MzAwYWEyZjFiY2RiMTk0MjI.
CSeq: 2 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username=“200”,realm=“asterisk”,nonce=“423b749f”,uri="sip:[email protected];transport=UDP",response=“648e75b93fe6e965eb63ee3bf5003a52”,algorithm=MD5
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
— (17 headers 0 lines) —
Creating new subscription
Sending to 192.168.1.104:61663 (NAT)
Found peer ‘200’ for ‘200’ from 192.168.1.104:61663

<— Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-85b7898ab2d27dee-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=7d58916f
To: sip:[email protected];transport=UDP;tag=as7558b1df
Call-ID: MjRhM2UwNDA1Y2Q2YjU5MzAwYWEyZjFiY2RiMTk0MjI.
CSeq: 2 SUBSCRIBE
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
Really destroying SIP dialog ‘MjRhM2UwNDA1Y2Q2YjU5MzAwYWEyZjFiY2RiMTk0MjI.’ Method: SUBSCRIBE
Really destroying SIP dialog ‘[email protected][::1]:5060’ Method: INVITE

<— SIP read from UDP:192.168.1.104:61663 —>
BYE sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-82b1b6b04eca4468-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP;tag=as7e97cebf
From: sip:[email protected];transport=UDP;tag=5678ab0d
Call-ID: YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.
CSeq: 3 BYE
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username=“200”,realm=“asterisk”,nonce=“65f3cf5a”,uri=“sip:[email protected]:5060”,response=“6c478be1a5cca433407b68c968b4e70d”,algorithm=MD5
Content-Length: 0

<------------->
— (11 headers 0 lines) —
Sending to 192.168.1.104:61663 (NAT)
Scheduling destruction of SIP dialog ‘YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.’ in 6400 ms (Method: BYE)

<— Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-82b1b6b04eca4468-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=5678ab0d
To: sip:[email protected];transport=UDP;tag=as7e97cebf
Call-ID: YmIxODIwZDRiOTY2ZDY5NjI1MGRlMGFkYmFiYWU0NzA.
CSeq: 3 BYE
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>

<— SIP read from UDP:192.168.1.104:61663 —>
PUBLISH sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-7d425121c0ccc5c4-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP
From: sip:[email protected];transport=UDP;tag=ca7f1149
Call-ID: NGExMjMyNDI5YWRjZTQ2NzE2ZTNiNjU4MmZkNTA3YWE.
CSeq: 1 PUBLISH
Expires: 600
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/pidf+xml
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence
Allow-Events: presence, kpml
Content-Length: 259

<?xml version="1.0" encoding="UTF-8"?>

open Online

<------------->
— (16 headers 3 lines) —
Sending to 192.168.1.104:61663 (NAT)

<— Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-7d425121c0ccc5c4-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=ca7f1149
To: sip:[email protected];transport=UDP;tag=as3a4c5281
Call-ID: NGExMjMyNDI5YWRjZTQ2NzE2ZTNiNjU4MmZkNTA3YWE.
CSeq: 1 PUBLISH
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
Really destroying SIP dialog ‘NGExMjMyNDI5YWRjZTQ2NzE2ZTNiNjU4MmZkNTA3YWE.’ Method: PUBLISH

<— SIP read from UDP:192.168.1.104:61663 —>
SUBSCRIBE sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-334b1d27e9bd5b2c-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP
From: sip:[email protected];transport=UDP;tag=96193006
Call-ID: ZDViNWM5NjU4NTdhNmE4ZTY2NjE3ODg3MmU1YTA0Zjg.
CSeq: 1 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
— (16 headers 0 lines) —
Sending to 192.168.1.104:61663 (NAT)
Creating new subscription
Sending to 192.168.1.104:61663 (NAT)
list_route: hop: sip:[email protected]:61663;transport=UDP
Found peer ‘200’ for ‘200’ from 192.168.1.104:61663

<— Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-334b1d27e9bd5b2c-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=96193006
To: sip:[email protected];transport=UDP;tag=as66348775
Call-ID: ZDViNWM5NjU4NTdhNmE4ZTY2NjE3ODg3MmU1YTA0Zjg.
CSeq: 1 SUBSCRIBE
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce="24280455"
Content-Length: 0

<------------>
Scheduling destruction of SIP dialog ‘ZDViNWM5NjU4NTdhNmE4ZTY2NjE3ODg3MmU1YTA0Zjg.’ in 6400 ms (Method: SUBSCRIBE)

<— SIP read from UDP:192.168.1.104:61663 —>
SUBSCRIBE sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-bc19031ad7a3fa8f-1—d8754z-
Max-Forwards: 70
Contact: sip:[email protected]:61663;transport=UDP
To: sip:[email protected];transport=UDP
From: sip:[email protected];transport=UDP;tag=96193006
Call-ID: ZDViNWM5NjU4NTdhNmE4ZTY2NjE3ODg3MmU1YTA0Zjg.
CSeq: 2 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username=“200”,realm=“asterisk”,nonce=“24280455”,uri="sip:[email protected];transport=UDP",response=“87af5af8deccd19b633a1e0564716fb8”,algorithm=MD5
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
— (17 headers 0 lines) —
Creating new subscription
Sending to 192.168.1.104:61663 (NAT)
Found peer ‘200’ for ‘200’ from 192.168.1.104:61663

<— Transmitting (NAT) to 192.168.1.104:61663 —>
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 192.168.1.104:61663;branch=z9hG4bK-d8754z-bc19031ad7a3fa8f-1—d8754z-;received=192.168.1.104;rport=61663
From: sip:[email protected];transport=UDP;tag=96193006
To: sip:[email protected];transport=UDP;tag=as66348775
Call-ID: ZDViNWM5NjU4NTdhNmE4ZTY2NjE3ODg3MmU1YTA0Zjg.
CSeq: 2 SUBSCRIBE
Server: FPBX-2.11.0(11.8.1)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
Really destroying SIP dialog ‘ZDViNWM5NjU4NTdhNmE4ZTY2NjE3ODg3MmU1YTA0Zjg.’ Method: SUBSCRIBE
REGISTER 10 headers, 0 lines
Reliably Transmitting (NAT) to 123.255.8.82:5060:
REGISTER sip:connect1.plus.snap.net.nz SIP/2.0
Via: SIP/2.0/UDP 192.168.1.177:5060;branch=z9hG4bK6c6c46ec;rport
Max-Forwards: 70
From: sip:[email protected];tag=as7e25fae3
To: sip:[email protected]
Call-ID: [email protected][::1]
CSeq: 154 REGISTER
User-Agent: FPBX-2.11.0(11.8.1)
Expires: 3700
Contact: sip:[email protected]192.168.1.177:5060
Content-Length: 0


<— SIP read from UDP:123.255.8.82:5060 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.177:5060;received=111.69.74.201;branch=z9hG4bK6c6c46ec;rport=15798
From: sip:[email protected];tag=as7e25fae3
To: sip:[email protected];tag=aprq6j6cuf2-jh8m2530000k9
Call-ID: [email protected][::1]
CSeq: 154 REGISTER
Contact: sip:[email protected]:5060;expires=30
Contact: sip:[email protected]:5060;expires=2047

<------------->
— (8 headers 0 lines) —
Really destroying SIP dialog ‘[email protected][::1]’ Method: REGISTER


Please let me know if I need to cut this log down… I was not sure what to leave out and what to include.

Which codecs are you using? Check that you have the same set of codecs enabled at both ends (Zoiper soft phone and FreePBX [Asterisk SIP Settings]).

Try renaming the trunk to Snap instead of Snap!

I have an odd feeling Dial is not going to be super happy with the “!”

Zoiper has the avaialbe Codecs “A-law, U’law” selected for use, these are alse selected for use in Aserisk SIP Settings also.

When I receive a call Zioper does show as using the codec “u-law”.
I have attached another log that looks a bit clearer using the command "asterisk -RvvvvT"
Please See below:

[May 1 10:39:04] Asterisk 11.8.1, Copyright © 1999 - 2013 Digium, Inc. and others.
[May 1 10:39:04] Created by Mark Spencer [email protected]
[May 1 10:39:04] Asterisk comes with ABSOLUTELY NO WARRANTY; type ‘core show warranty’ for details.
[May 1 10:39:04] This is free software, with components licensed under the GNU General Public
[May 1 10:39:04] License version 2 and other licenses; you are welcome to redistribute it under
[May 1 10:39:04] certain conditions. Type ‘core show license’ for details.
[May 1 10:39:04] =========================================================================
[May 1 10:39:04] Connected to Asterisk 11.8.1 currently running on localhost (pid = 1663)
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Executing [[email protected]:1] Macro(“SIP/200-00000009”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
– Executing [[email protected]:1] Set(“SIP/200-00000009”, “TOUCH_MONITOR=1398897549.9”) in new stack
– Executing [[email protected]:2] Set(“SIP/200-00000009”, “AMPUSER=200”) in new stack
– Executing [[email protected]:3] GotoIf(“SIP/200-00000009”, “0?report”) in new stack
– Executing [[email protected]:4] ExecIf(“SIP/200-00000009”, “1?Set(REALCALLERIDNUM=200)”) in new stack
– Executing [[email protected]:5] Set(“SIP/200-00000009”, “AMPUSER=200”) in new stack
– Executing [[email protected]:6] GotoIf(“SIP/200-00000009”, “0?limit”) in new stack
– Executing [[email protected]:7] Set(“SIP/200-00000009”, “AMPUSERCIDNAME=Jeremy & Kelly”) in new stack
– Executing [[email protected]:8] GotoIf(“SIP/200-00000009”, “0?report”) in new stack
– Executing [[email protected]:9] Set(“SIP/200-00000009”, “AMPUSERCID=200”) in new stack
– Executing [[email protected]:10] Set(“SIP/200-00000009”, “__DIAL_OPTIONS=Ttr”) in new stack
– Executing [[email protected]:11] Set(“SIP/200-00000009”, “CALLERID(all)=“Jeremy & Kelly” <200>”) in new stack
– Executing [[email protected]:12] GotoIf(“SIP/200-00000009”, “0?limit”) in new stack
– Executing [[email protected]:13] ExecIf(“SIP/200-00000009”, “1?Set(GROUP(concurrency_limit)=200)”) in new stack
– Executing [[email protected]:14] ExecIf(“SIP/200-00000009”, “0?Set(CHANNEL(language)=)”) in new stack
– Executing [[email protected]:15] GosubIf(“SIP/200-00000009”, “7?sub-ccss,s,1(from-internal,0276290535)”) in new stack
– Executing [[email protected]:1] ExecIf(“SIP/200-00000009”, “0?Return()”) in new stack
– Executing [[email protected]:2] Set(“SIP/200-00000009”, “CCSS_SETUP=TRUE”) in new stack
– Executing [[email protected]:3] GosubIf(“SIP/200-00000009”, “0?monitor_config,1(from-internal,0276290535):monitor_default,1(from-internal,0276290535)”) in new stack
– Executing [[email protected]:1] GotoIf(“SIP/200-00000009”, “0?is_exten”) in new stack
– Executing [[email protected]:2] StackPop(“SIP/200-00000009”, “”) in new stack
– Executing [[email protected]:3] Return(“SIP/200-00000009”, “FALSE”) in new stack
– Executing [[email protected]:16] GotoIf(“SIP/200-00000009”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,29)
– Executing [[email protected]:29] Set(“SIP/200-00000009”, “CALLERID(number)=200”) in new stack
– Executing [[email protected]:30] Set(“SIP/200-00000009”, “CALLERID(name)=Jeremy & Kelly”) in new stack
– Executing [[email protected]:31] Set(“SIP/200-00000009”, “CDR(cnum)=200”) in new stack
– Executing [[email protected]:32] Set(“SIP/200-00000009”, “CDR(cnam)=Jeremy & Kelly”) in new stack
– Executing [[email protected]:33] Set(“SIP/200-00000009”, “CHANNEL(language)=en”) in new stack
– Executing [[email protected]:2] Set(“SIP/200-00000009”, “MOHCLASS=default”) in new stack
– Executing [[email protected]:3] Set(“SIP/200-00000009”, “_NODEST=”) in new stack
– Executing [[email protected]:4] Gosub(“SIP/200-00000009”, “sub-record-check,s,1(out,0276290535,)”) in new stack
– Executing [[email protected]:1] Set(“SIP/200-00000009”, “REC_POLICY_MODE_SAVE=”) in new stack
– Executing [[email protected]:2] GotoIf(“SIP/200-00000009”, “1?check”) in new stack
– Goto (sub-record-check,s,7)
– Executing [[email protected]:7] Set(“SIP/200-00000009”, “__MON_FMT=wav”) in new stack
– Executing [[email protected]:8] GotoIf(“SIP/200-00000009”, “1?next”) in new stack
– Goto (sub-record-check,s,11)
– Executing [[email protected]:11] ExecIf(“SIP/200-00000009”, “0?Return()”) in new stack
– Executing [[email protected]:12] ExecIf(“SIP/200-00000009”, “0?Set(__REC_POLICY_MODE=)”) in new stack
– Executing [[email protected]:13] GotoIf(“SIP/200-00000009”, “0?out,1”) in new stack
– Executing [[email protected]:14] Set(“SIP/200-00000009”, “__REC_STATUS=INITIALIZED”) in new stack
– Executing [[email protected]:15] Set(“SIP/200-00000009”, “NOW=1398897549”) in new stack
– Executing [[email protected]:16] Set(“SIP/200-00000009”, “__DAY=01”) in new stack
– Executing [[email protected]:17] Set(“SIP/200-00000009”, “__MONTH=05”) in new stack
– Executing [[email protected]:18] Set(“SIP/200-00000009”, “__YEAR=2014”) in new stack
– Executing [[email protected]:19] Set(“SIP/200-00000009”, “__TIMESTR=20140501-103909”) in new stack
– Executing [[email protected]:20] Set(“SIP/200-00000009”, “__FROMEXTEN=200”) in new stack
– Executing [[email protected]:21] Set(“SIP/200-00000009”, “__CALLFILENAME=out-0276290535-200-20140501-103909-1398897549.9”) in new stack
– Executing [[email protected]:22] Goto(“SIP/200-00000009”, “out,1”) in new stack
– Goto (sub-record-check,out,1)
– Executing [[email protected]:1] ExecIf(“SIP/200-00000009”, “1?Set(__REC_POLICY_MODE=dontcare)”) in new stack
– Executing [[email protected]:2] GosubIf(“SIP/200-00000009”, “0?record,1(exten,0276290535,200)”) in new stack
– Executing [[email protected]:3] Return(“SIP/200-00000009”, “”) in new stack
– Executing [[email protected]:5] Macro(“SIP/200-00000009”, “dialout-trunk,2,0276290535,off”) in new stack
– Executing [[email protected]:1] Set(“SIP/200-00000009”, “DIAL_TRUNK=2”) in new stack
– Executing [[email protected]:2] GosubIf(“SIP/200-00000009”, “0?sub-pincheck,s,1()”) in new stack
– Executing [[email protected]:3] GotoIf(“SIP/200-00000009”, “0?disabletrunk,1”) in new stack
– Executing [[email protected]:4] Set(“SIP/200-00000009”, “DIAL_NUMBER=0276290535”) in new stack
– Executing [[email protected]:5] Set(“SIP/200-00000009”, “DIAL_TRUNK_OPTIONS=Ttr”) in new stack
– Executing [[email protected]:6] Set(“SIP/200-00000009”, “OUTBOUND_GROUP=OUT_2”) in new stack
– Executing [[email protected]:7] GotoIf(“SIP/200-00000009”, “1?nomax”) in new stack
– Goto (macro-dialout-trunk,s,9)
– Executing [[email protected]:9] GotoIf(“SIP/200-00000009”, “0?skipoutcid”) in new stack
– Executing [[email protected]:10] Set(“SIP/200-00000009”, “DIAL_TRUNK_OPTIONS=Tt”) in new stack
– Executing [[email protected]:11] Macro(“SIP/200-00000009”, “outbound-callerid,2”) in new stack
– Executing [[email protected]:1] ExecIf(“SIP/200-00000009”, “0?Set(CALLERPRES()=)”) in new stack
– Executing [[email protected]:2] ExecIf(“SIP/200-00000009”, “0?Set(REALCALLERIDNUM=200)”) in new stack
– Executing [[email protected]:3] GotoIf(“SIP/200-00000009”, “1?normcid”) in new stack
– Goto (macro-outbound-callerid,s,6)
– Executing [[email protected]:6] Set(“SIP/200-00000009”, “USEROUTCID=”) in new stack
– Executing [[email protected]:7] Set(“SIP/200-00000009”, “EMERGENCYCID=”) in new stack
– Executing [[email protected]:8] Set(“SIP/200-00000009”, “TRUNKOUTCID=072600500”) in new stack
– Executing [[email protected]:9] GotoIf(“SIP/200-00000009”, “1?trunkcid”) in new stack
– Goto (macro-outbound-callerid,s,14)
– Executing [[email protected]:14] ExecIf(“SIP/200-00000009”, “1?Set(CALLERID(all)=072600500)”) in new stack
– Executing [[email protected]:15] ExecIf(“SIP/200-00000009”, “0?Set(CALLERID(all)=)”) in new stack
– Executing [[email protected]:16] ExecIf(“SIP/200-00000009”, “0?Set(CALLERID(all)=)”) in new stack
– Executing [[email protected]:17] ExecIf(“SIP/200-00000009”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
– Executing [[email protected]:18] Set(“SIP/200-00000009”, “CDR(outbound_cnum)=072600500”) in new stack
– Executing [[email protected]:19] Set(“SIP/200-00000009”, “CDR(outbound_cnam)=”) in new stack
– Executing [[email protected]:12] GosubIf(“SIP/200-00000009”, “0?sub-flp-2,s,1()”) in new stack
– Executing [[email protected]:13] Set(“SIP/200-00000009”, “OUTNUM=0276290535”) in new stack
– Executing [[email protected]:14] Set(“SIP/200-00000009”, “custom=SIP/Snap!”) in new stack
– Executing [[email protected]:15] ExecIf(“SIP/200-00000009”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)Tt)”) in new stack
– Executing [[email protected]:16] ExecIf(“SIP/200-00000009”, “0?Set(DIAL_TRUNK_OPTIONS=TtM(confirm))”) in new stack
– Executing [[email protected]:17] Macro(“SIP/200-00000009”, “dialout-trunk-predial-hook,”) in new stack
– Executing [[email protected]:1] MacroExit(“SIP/200-00000009”, “”) in new stack
– Executing [[email protected]:18] GotoIf(“SIP/200-00000009”, “0?bypass,1”) in new stack
– Executing [[email protected]:19] ExecIf(“SIP/200-00000009”, “1?Set(CONNECTEDLINE(num,i)=0276290535)”) in new stack
– Executing [[email protected]:20] ExecIf(“SIP/200-00000009”, “1?Set(CONNECTEDLINE(name,i)=CID:072600500)”) in new stack
– Executing [[email protected]:21] GotoIf(“SIP/200-00000009”, “0?customtrunk”) in new stack
– Executing [[email protected]:22] Dial(“SIP/200-00000009”, “SIP/Snap!/0276290535,300,Tt”) in new stack
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
== Everyone is busy/congested at this time (1:0/0/1)
– Executing [[email protected]:23] NoOp(“SIP/200-00000009”, “Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 20”) in new stack
– Executing [[email protected]:24] GotoIf(“SIP/200-00000009”, “0?continue,1:s-CHANUNAVAIL,1”) in new stack
– Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)
– Executing [[email protected]:1] Set(“SIP/200-00000009”, “RC=20”) in new stack
– Executing [[email protected]:2] Goto(“SIP/200-00000009”, “20,1”) in new stack
– Goto (macro-dialout-trunk,20,1)
– Executing [[email protected]:1] Goto(“SIP/200-00000009”, “continue,1”) in new stack
– Goto (macro-dialout-trunk,continue,1)
– Executing [[email protected]:1] NoOp(“SIP/200-00000009”, “TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 20 - failing through to other trunks”) in new stack
– Executing [[email protected]:2] Set(“SIP/200-00000009”, “CALLERID(number)=200”) in new stack
– Executing [[email protected]:6] Macro(“SIP/200-00000009”, “outisbusy,”) in new stack
– Executing [[email protected]:1] Progress(“SIP/200-00000009”, “”) in new stack
– Executing [[email protected]:2] GotoIf(“SIP/200-00000009”, “0?emergency,1”) in new stack
– Executing [[email protected]:3] GotoIf(“SIP/200-00000009”, “0?intracompany,1”) in new stack
– Executing [[email protected]:4] Playback(“SIP/200-00000009”, “all-circuits-busy-now&pls-try-call-later, noanswer”) in new stack
– <SIP/200-00000009> Playing ‘all-circuits-busy-now.ulaw’ (language ‘en’)
> 0xb74404d8 – Probation passed - setting RTP source address to 192.168.1.104:8000
– <SIP/200-00000009> Playing ‘pls-try-call-later.ulaw’ (language ‘en’)
– Executing [[email protected]:5] Congestion(“SIP/200-00000009”, “20”) in new stack
== Spawn extension (macro-outisbusy, s, 5) exited non-zero on ‘SIP/200-00000009’ in macro ‘outisbusy’
== Spawn extension (from-internal, 0276290535, 6) exited non-zero on ‘SIP/200-00000009’
– Executing [[email protected]:1] Hangup(“SIP/200-00000009”, “”) in new stack
== Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/200-00000009’

Thanks for that jfinstrom,
I did have that thought but at 2am I didnt bother to change it and went to bed, so I have taken out the “!” in the trunk name and am making some progress now!

Zoiper is now establishing the call but after a few seconds it comes back saying the dialed number is not availabble at this time.
EDIT: After trying a second time it dialled without issue!
I can beleive I overlooked something so simple! Doh!
Thanks alot guys I reapply appreciate your time in helping me resolve this.