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

bonkas · April 30, 2014, 12:38pm

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];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 ‘5a3fb98747c60ffe0377f38c6ddaabae@[::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: 584cf1ad2794463d1e0736e076f22f30@[::1]

CSeq: 154 REGISTER

User-Agent: FPBX-2.11.0(11.8.1)

Expires: 3700

Contact: sip:[email protected]: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: 584cf1ad2794463d1e0736e076f22f30@[::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 ‘584cf1ad2794463d1e0736e076f22f30@[::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.

leemason · April 30, 2014, 4:08pm

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]).

jfinstrom · April 30, 2014, 11:13pm

Try renaming the trunk to Snap instead of Snap!

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

bonkas · April 30, 2014, 10:45pm

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 [0276290535@from-internal:1] Macro(“SIP/200-00000009”, “user-callerid,LIMIT,EXTERNAL,”) in new stack – Executing [s@macro-user-callerid:1] Set(“SIP/200-00000009”, “TOUCH_MONITOR=1398897549.9”) in new stack – Executing [s@macro-user-callerid:2] Set(“SIP/200-00000009”, “AMPUSER=200”) in new stack – Executing [s@macro-user-callerid:3] GotoIf(“SIP/200-00000009”, “0?report”) in new stack – Executing [s@macro-user-callerid:4] ExecIf(“SIP/200-00000009”, “1?Set(REALCALLERIDNUM=200)”) in new stack – Executing [s@macro-user-callerid:5] Set(“SIP/200-00000009”, “AMPUSER=200”) in new stack – Executing [s@macro-user-callerid:6] GotoIf(“SIP/200-00000009”, “0?limit”) in new stack – Executing [s@macro-user-callerid:7] Set(“SIP/200-00000009”, “AMPUSERCIDNAME=Jeremy & Kelly”) in new stack – Executing [s@macro-user-callerid:8] GotoIf(“SIP/200-00000009”, “0?report”) in new stack – Executing [s@macro-user-callerid:9] Set(“SIP/200-00000009”, “AMPUSERCID=200”) in new stack – Executing [s@macro-user-callerid:10] Set(“SIP/200-00000009”, “__DIAL_OPTIONS=Ttr”) in new stack – Executing [s@macro-user-callerid:11] Set(“SIP/200-00000009”, “CALLERID(all)=“Jeremy & Kelly” <200>”) in new stack – Executing [s@macro-user-callerid:12] GotoIf(“SIP/200-00000009”, “0?limit”) in new stack – Executing [s@macro-user-callerid:13] ExecIf(“SIP/200-00000009”, “1?Set(GROUP(concurrency_limit)=200)”) in new stack – Executing [s@macro-user-callerid:14] ExecIf(“SIP/200-00000009”, “0?Set(CHANNEL(language)=)”) in new stack – Executing [s@macro-user-callerid:15] GosubIf(“SIP/200-00000009”, “7?sub-ccss,s,1(from-internal,0276290535)”) in new stack – Executing [s@sub-ccss:1] ExecIf(“SIP/200-00000009”, “0?Return()”) in new stack – Executing [s@sub-ccss:2] Set(“SIP/200-00000009”, “CCSS_SETUP=TRUE”) in new stack – Executing [s@sub-ccss:3] GosubIf(“SIP/200-00000009”, “0?monitor_config,1(from-internal,0276290535):monitor_default,1(from-internal,0276290535)”) in new stack – Executing [monitor_default@sub-ccss:1] GotoIf(“SIP/200-00000009”, “0?is_exten”) in new stack – Executing [monitor_default@sub-ccss:2] StackPop(“SIP/200-00000009”, “”) in new stack – Executing [monitor_default@sub-ccss:3] Return(“SIP/200-00000009”, “FALSE”) in new stack – Executing [s@macro-user-callerid:16] GotoIf(“SIP/200-00000009”, “1?continue”) in new stack – Goto (macro-user-callerid,s,29) – Executing [s@macro-user-callerid:29] Set(“SIP/200-00000009”, “CALLERID(number)=200”) in new stack – Executing [s@macro-user-callerid:30] Set(“SIP/200-00000009”, “CALLERID(name)=Jeremy & Kelly”) in new stack – Executing [s@macro-user-callerid:31] Set(“SIP/200-00000009”, “CDR(cnum)=200”) in new stack – Executing [s@macro-user-callerid:32] Set(“SIP/200-00000009”, “CDR(cnam)=Jeremy & Kelly”) in new stack – Executing [s@macro-user-callerid:33] Set(“SIP/200-00000009”, “CHANNEL(language)=en”) in new stack – Executing [0276290535@from-internal:2] Set(“SIP/200-00000009”, “MOHCLASS=default”) in new stack – Executing [0276290535@from-internal:3] Set(“SIP/200-00000009”, “_NODEST=”) in new stack – Executing [0276290535@from-internal:4] Gosub(“SIP/200-00000009”, “sub-record-check,s,1(out,0276290535,)”) in new stack – Executing [s@sub-record-check:1] Set(“SIP/200-00000009”, “REC_POLICY_MODE_SAVE=”) in new stack – Executing [s@sub-record-check:2] GotoIf(“SIP/200-00000009”, “1?check”) in new stack – Goto (sub-record-check,s,7) – Executing [s@sub-record-check:7] Set(“SIP/200-00000009”, “__MON_FMT=wav”) in new stack – Executing [s@sub-record-check:8] GotoIf(“SIP/200-00000009”, “1?next”) in new stack – Goto (sub-record-check,s,11) – Executing [s@sub-record-check:11] ExecIf(“SIP/200-00000009”, “0?Return()”) in new stack – Executing [s@sub-record-check:12] ExecIf(“SIP/200-00000009”, “0?Set(__REC_POLICY_MODE=)”) in new stack – Executing [s@sub-record-check:13] GotoIf(“SIP/200-00000009”, “0?out,1”) in new stack – Executing [s@sub-record-check:14] Set(“SIP/200-00000009”, “__REC_STATUS=INITIALIZED”) in new stack – Executing [s@sub-record-check:15] Set(“SIP/200-00000009”, “NOW=1398897549”) in new stack – Executing [s@sub-record-check:16] Set(“SIP/200-00000009”, “__DAY=01”) in new stack – Executing [s@sub-record-check:17] Set(“SIP/200-00000009”, “__MONTH=05”) in new stack – Executing [s@sub-record-check:18] Set(“SIP/200-00000009”, “__YEAR=2014”) in new stack – Executing [s@sub-record-check:19] Set(“SIP/200-00000009”, “__TIMESTR=20140501-103909”) in new stack – Executing [s@sub-record-check:20] Set(“SIP/200-00000009”, “__FROMEXTEN=200”) in new stack – Executing [s@sub-record-check:21] Set(“SIP/200-00000009”, “__CALLFILENAME=out-0276290535-200-20140501-103909-1398897549.9”) in new stack – Executing [s@sub-record-check:22] Goto(“SIP/200-00000009”, “out,1”) in new stack – Goto (sub-record-check,out,1) – Executing [out@sub-record-check:1] ExecIf(“SIP/200-00000009”, “1?Set(__REC_POLICY_MODE=dontcare)”) in new stack – Executing [out@sub-record-check:2] GosubIf(“SIP/200-00000009”, “0?record,1(exten,0276290535,200)”) in new stack – Executing [out@sub-record-check:3] Return(“SIP/200-00000009”, “”) in new stack – Executing [0276290535@from-internal:5] Macro(“SIP/200-00000009”, “dialout-trunk,2,0276290535,off”) in new stack – Executing [s@macro-dialout-trunk:1] Set(“SIP/200-00000009”, “DIAL_TRUNK=2”) in new stack – Executing [s@macro-dialout-trunk:2] GosubIf(“SIP/200-00000009”, “0?sub-pincheck,s,1()”) in new stack – Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/200-00000009”, “0?disabletrunk,1”) in new stack – Executing [s@macro-dialout-trunk:4] Set(“SIP/200-00000009”, “DIAL_NUMBER=0276290535”) in new stack – Executing [s@macro-dialout-trunk:5] Set(“SIP/200-00000009”, “DIAL_TRUNK_OPTIONS=Ttr”) in new stack – Executing [s@macro-dialout-trunk:6] Set(“SIP/200-00000009”, “OUTBOUND_GROUP=OUT_2”) in new stack – Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/200-00000009”, “1?nomax”) in new stack – Goto (macro-dialout-trunk,s,9) – Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/200-00000009”, “0?skipoutcid”) in new stack – Executing [s@macro-dialout-trunk:10] Set(“SIP/200-00000009”, “DIAL_TRUNK_OPTIONS=Tt”) in new stack – Executing [s@macro-dialout-trunk:11] Macro(“SIP/200-00000009”, “outbound-callerid,2”) in new stack – Executing [s@macro-outbound-callerid:1] ExecIf(“SIP/200-00000009”, “0?Set(CALLERPRES()=)”) in new stack – Executing [s@macro-outbound-callerid:2] ExecIf(“SIP/200-00000009”, “0?Set(REALCALLERIDNUM=200)”) in new stack – Executing [s@macro-outbound-callerid:3] GotoIf(“SIP/200-00000009”, “1?normcid”) in new stack – Goto (macro-outbound-callerid,s,6) – Executing [s@macro-outbound-callerid:6] Set(“SIP/200-00000009”, “USEROUTCID=”) in new stack – Executing [s@macro-outbound-callerid:7] Set(“SIP/200-00000009”, “EMERGENCYCID=”) in new stack – Executing [s@macro-outbound-callerid:8] Set(“SIP/200-00000009”, “TRUNKOUTCID=072600500”) in new stack – Executing [s@macro-outbound-callerid:9] GotoIf(“SIP/200-00000009”, “1?trunkcid”) in new stack – Goto (macro-outbound-callerid,s,14) – Executing [s@macro-outbound-callerid:14] ExecIf(“SIP/200-00000009”, “1?Set(CALLERID(all)=072600500)”) in new stack – Executing [s@macro-outbound-callerid:15] ExecIf(“SIP/200-00000009”, “0?Set(CALLERID(all)=)”) in new stack – Executing [s@macro-outbound-callerid:16] ExecIf(“SIP/200-00000009”, “0?Set(CALLERID(all)=)”) in new stack – Executing [s@macro-outbound-callerid:17] ExecIf(“SIP/200-00000009”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack – Executing [s@macro-outbound-callerid:18] Set(“SIP/200-00000009”, “CDR(outbound_cnum)=072600500”) in new stack – Executing [s@macro-outbound-callerid:19] Set(“SIP/200-00000009”, “CDR(outbound_cnam)=”) in new stack – Executing [s@macro-dialout-trunk:12] GosubIf(“SIP/200-00000009”, “0?sub-flp-2,s,1()”) in new stack – Executing [s@macro-dialout-trunk:13] Set(“SIP/200-00000009”, “OUTNUM=0276290535”) in new stack – Executing [s@macro-dialout-trunk:14] Set(“SIP/200-00000009”, “custom=SIP/Snap!”) in new stack – Executing [s@macro-dialout-trunk:15] ExecIf(“SIP/200-00000009”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)Tt)”) in new stack – Executing [s@macro-dialout-trunk:16] ExecIf(“SIP/200-00000009”, “0?Set(DIAL_TRUNK_OPTIONS=TtM(confirm))”) in new stack – Executing [s@macro-dialout-trunk:17] Macro(“SIP/200-00000009”, “dialout-trunk-predial-hook,”) in new stack – Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/200-00000009”, “”) in new stack – Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/200-00000009”, “0?bypass,1”) in new stack – Executing [s@macro-dialout-trunk:19] ExecIf(“SIP/200-00000009”, “1?Set(CONNECTEDLINE(num,i)=0276290535)”) in new stack – Executing [s@macro-dialout-trunk:20] ExecIf(“SIP/200-00000009”, “1?Set(CONNECTEDLINE(name,i)=CID:072600500)”) in new stack – Executing [s@macro-dialout-trunk:21] GotoIf(“SIP/200-00000009”, “0?customtrunk”) in new stack – Executing [s@macro-dialout-trunk: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 [s@macro-dialout-trunk:23] NoOp(“SIP/200-00000009”, “Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 20”) in new stack – Executing [s@macro-dialout-trunk:24] GotoIf(“SIP/200-00000009”, “0?continue,1:s-CHANUNAVAIL,1”) in new stack – Goto (macro-dialout-trunk,s-CHANUNAVAIL,1) – Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set(“SIP/200-00000009”, “RC=20”) in new stack – Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto(“SIP/200-00000009”, “20,1”) in new stack – Goto (macro-dialout-trunk,20,1) – Executing [20@macro-dialout-trunk:1] Goto(“SIP/200-00000009”, “continue,1”) in new stack – Goto (macro-dialout-trunk,continue,1) – Executing [continue@macro-dialout-trunk:1] NoOp(“SIP/200-00000009”, “TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 20 - failing through to other trunks”) in new stack – Executing [continue@macro-dialout-trunk:2] Set(“SIP/200-00000009”, “CALLERID(number)=200”) in new stack – Executing [0276290535@from-internal:6] Macro(“SIP/200-00000009”, “outisbusy,”) in new stack – Executing [s@macro-outisbusy:1] Progress(“SIP/200-00000009”, “”) in new stack – Executing [s@macro-outisbusy:2] GotoIf(“SIP/200-00000009”, “0?emergency,1”) in new stack – Executing [s@macro-outisbusy:3] GotoIf(“SIP/200-00000009”, “0?intracompany,1”) in new stack – Executing [s@macro-outisbusy: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 [s@macro-outisbusy: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 [h@from-internal:1] Hangup(“SIP/200-00000009”, “”) in new stack == Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/200-00000009’

bonkas · April 30, 2014, 11:27pm

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.