Pin SET NOT working, call hangups

dragonauta29
Joined: Thu 29 of Mar, 2012

Pin SET NOT working, call hangups

Posted:Thu 29 of Mar, 2012 (19:18 UTC)
Hello guys,

I have a problem(at least for me), i´ve got a working trunk between a Cisco call Manager and my Asterisk, the internal calls are working(CISCO extensions to Asterisk extensions and Asterisk extensions to Cisco Extensions), external calls also work perfectly when i´m not using PIN SETS,but, then (for security and billing reasons when) when i try to use PIN SETS Asterisk just hangs up the call, according to what i see on the logs it doesn even call the CISCO trunk to pass it on.
I mean that if i create an Outbound route and tell it to use a Pin SET, then Asterisk just hangup the call, it doesnt even try to go to the Cisco Call Manager, it just Hangs up the call...it is realy driving me crazy since i cant find a sane reason for that.
Here´s the log with DEBUG OFF:

 -- Executing [10923640102@from-internal:1] Macro("SIP/2501-00000006", "user-callerid,SKIPTTL,") in new stack
    -- Executing [s@macro-user-callerid:1] Set("SIP/2501-00000006", "AMPUSER=2501") in new stack
    -- Executing [s@macro-user-callerid:2] GotoIf("SIP/2501-00000006", "0?report") in new stack
    -- Executing [s@macro-user-callerid:3] ExecIf("SIP/2501-00000006", "1?Set(REALCALLERIDNUM=2501)") in new stack
    -- Executing [s@macro-user-callerid:4] Set("SIP/2501-00000006", "AMPUSER=2501") in new stack
    -- Executing [s@macro-user-callerid:5] Set("SIP/2501-00000006", "AMPUSERCIDNAME=Ramal 2501") in new stack
    -- Executing [s@macro-user-callerid:6] GotoIf("SIP/2501-00000006", "0?report") in new stack
    -- Executing [s@macro-user-callerid:7] Set("SIP/2501-00000006", "AMPUSERCID=2501") in new stack
    -- Executing [s@macro-user-callerid:8] Set("SIP/2501-00000006", "CALLERID(all)="Ramal 2501" <2501>") in new stack
    -- Executing [s@macro-user-callerid:9] ExecIf("SIP/2501-00000006", "0?Set(CHANNEL(language)=)") in new stack
    -- Executing [s@macro-user-callerid:10] GotoIf("SIP/2501-00000006", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,19)
    -- Executing [s@macro-user-callerid:19] Set("SIP/2501-00000006", "CALLERID(number)=2501") in new stack
    -- Executing [s@macro-user-callerid:20] Set("SIP/2501-00000006", "CALLERID(name)=Ramal 2501") in new stack
    -- Executing [s@macro-user-callerid:21] NoOp("SIP/2501-00000006", "Using CallerID "Ramal 2501" <2501>") in new stack
    -- Executing [10923640102@from-internal:2] Macro("SIP/2501-00000006", "pinsets,2,0") in new stack
    -- Executing [s@macro-pinsets:1] GotoIf("SIP/2501-00000006", "0 = 1?cdr,1") in new stack
    -- Executing [s@macro-pinsets:2] ExecIf("SIP/2501-00000006", "1?Authenticate(/etc/asterisk/pinset_2)") in new stack
  == Spawn extension (macro-pinsets, s, 2) exited non-zero on 'SIP/2501-00000006' in macro 'pinsets'
  == Spawn extension (from-internal, 10923640102, 2) exited non-zero on 'SIP/2501-00000006'
    -- Executing [h@from-internal:1] Macro("SIP/2501-00000006", "hangupcall") in new stack
    -- Executing [s@macro-hangupcall:1] GotoIf("SIP/2501-00000006", "1?endmixmoncheck") in new stack
    -- Goto (macro-hangupcall,s,9)
    -- Executing [s@macro-hangupcall:9] NoOp("SIP/2501-00000006", "End of MIXMON check") in new stack
    -- Executing [s@macro-hangupcall:10] GotoIf("SIP/2501-00000006", "1?nomeetmemon") in new stack
    -- Goto (macro-hangupcall,s,15)
    -- Executing [s@macro-hangupcall:15] NoOp("SIP/2501-00000006", "MEETME_RECORDINGFILE=") in new stack
    -- Executing [s@macro-hangupcall:16] GotoIf("SIP/2501-00000006", "1?noautomon") in new stack
    -- Goto (macro-hangupcall,s,18)
    -- Executing [s@macro-hangupcall:18] NoOp("SIP/2501-00000006", "TOUCH_MONITOR_OUTPUT=") in new stack
    -- Executing [s@macro-hangupcall:19] GotoIf("SIP/2501-00000006", "1?noautomon2") in new stack
    -- Goto (macro-hangupcall,s,25)
    -- Executing [s@macro-hangupcall:25] NoOp("SIP/2501-00000006", "MONITOR_FILENAME=") in new stack
    -- Executing [s@macro-hangupcall:26] GotoIf("SIP/2501-00000006", "1?skiprg") in new stack
    -- Goto (macro-hangupcall,s,29)
    -- Executing [s@macro-hangupcall:29] GotoIf("SIP/2501-00000006", "1?skipblkvm") in new stack
    -- Goto (macro-hangupcall,s,32)
    -- Executing [s@macro-hangupcall:32] GotoIf("SIP/2501-00000006", "1?theend") in new stack
    -- Goto (macro-hangupcall,s,34)
    -- Executing [s@macro-hangupcall:34] Hangup("SIP/2501-00000006", "") in new stack
  == Spawn extension (macro-hangupcall, s, 34) exited non-zero on 'SIP/2501-00000006' in macro 'hangupcall'
  == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/2501-00000006

And Here it is with DEBUG ON:

---
Retransmitting #1 (NAT) to 10.9.200.54:8575:
BYE sip:2501@10.9.200.54:8575 SIP/2.0
Via: SIP/2.0/UDP 10.9.200.18:5060;branch=z9hG4bK72755d84;rport
Max-Forwards: 70
From: <sip:10923640102@10.9.200.18>;tag=as1e2ec67b
To: "2501" <sip:2501@10.9.200.18>;tag=7d9a75f7
Call-ID: 1ec0db750787ee196d20af2b7ccc6805@10.9.200.54
CSeq: 102 BYE
User-Agent: FPBX-2.8.1(1.8.10.0)
Proxy-Authorization: Digest username="2501", realm="asterisk", algorithm=MD5, uri="sip:10.9.200.18", nonce="", response="7738ff1563893de5ceaca0eb17805a05"
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0


---

<--- SIP read from UDP:10.9.200.54:8575 --->
ACK sip:10923640102@10.9.200.18:5060 SIP/2.0
Via: SIP/2.0/UDP 10.9.200.54:8575;rport;branch=z9hG4bKa0274e8d1a
From: "2501" <sip:2501@10.9.200.18>;tag=7d9a75f7
To: <sip:10923640102@10.9.200.18>;tag=as1e2ec67b
Call-ID: 1ec0db750787ee196d20af2b7ccc6805@10.9.200.54
Contact: <sip:2501@10.9.200.54:8575>
CSeq: 2 ACK
Max-Forwards: 70
Authorization: Digest username="2501",realm="asterisk",nonce="3acf6b81",response="2880402f5aa002d7481a65db2f652b57",uri="sip:10923640102@10.9.200.18",algorithm=MD5
User-Agent: Intelbras (812240.0306.G3)
Content-Length: 0

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

<--- SIP read from UDP:10.9.200.54:8575 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.9.200.18:5060;rport=5060;received=10.9.200.18;branch=z9hG4bK72755d84
From: <sip:10923640102@10.9.200.18>;tag=as1e2ec67b
To: "2501" <sip:2501@10.9.200.18>;tag=7d9a75f7
Call-ID: 1ec0db750787ee196d20af2b7ccc6805@10.9.200.54
CSeq: 102 BYE
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
SIP Response message for INCOMING dialog BYE arrived
Really destroying SIP dialog '1ec0db750787ee196d20af2b7ccc6805@10.9.200.54' Method: ACK

<--- SIP read from UDP:10.9.200.54:8575 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.9.200.18:5060;rport=5060;received=10.9.200.18;branch=z9hG4bK72755d84
From: <sip:10923640102@10.9.200.18>;tag=as1e2ec67b
To: "2501" <sip:2501@10.9.200.18>;tag=7d9a75f7
Call-ID: 1ec0db750787ee196d20af2b7ccc6805@10.9.200.54
CSeq: 102 BYE
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---

<--- SIP read from UDP:10.9.200.54:8575 --->
REGISTER sip:10.9.200.18 SIP/2.0
Via: SIP/2.0/UDP 10.9.200.54:8575;rport;branch=z9hG4bK45ce9a74a9
From: "2501" <sip:2501@10.9.200.18>;tag=081e2cb5
To: "2501" <sip:2501@10.9.200.18>
Call-ID: 2e5d5137707f09a824532e4b5104508e@10.9.200.54
Contact: <sip:2501@10.9.200.54:8575>
CSeq: 493 REGISTER
Max-Forwards: 70
Expires: 60
Allow: INVITE,CANCEL,ACK,BYE,NOTIFY,REFER,OPTIONS,INFO,MESSAGE,UPDATE
Authorization: Digest username="2501",realm="asterisk",nonce="380ca7a5",response="8ac5553b90778f0f727ea462a1570cca",uri="sip:2501@10.9.200.18",algorithm=MD5
User-Agent: Intelbras (812240.0306.G3)
Content-Length: 0

<------------->
--- (13 headers 0 lines) ---
Sending to 10.9.200.54:8575 (NAT)

<--- Transmitting (NAT) to 10.9.200.54:8575 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.9.200.54:8575;branch=z9hG4bK45ce9a74a9;received=10.9.200.54;rport=8575
From: "2501" <sip:2501@10.9.200.18>;tag=081e2cb5
To: "2501" <sip:2501@10.9.200.18>;tag=as04bcac9e
Call-ID: 2e5d5137707f09a824532e4b5104508e@10.9.200.54
CSeq: 493 REGISTER
Server: FPBX-2.8.1(1.8.10.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="3e415622"
Content-Length: 0


<------------>
Scheduling destruction of SIP dialog '2e5d5137707f09a824532e4b5104508e@10.9.200.54' in 32000 ms (Method: REGISTER)

<--- SIP read from UDP:10.9.200.54:8575 --->
REGISTER sip:10.9.200.18 SIP/2.0
Via: SIP/2.0/UDP 10.9.200.54:8575;rport;branch=z9hG4bKb5b7b57aba
From: "2501" <sip:2501@10.9.200.18>;tag=081e2cb5
To: "2501" <sip:2501@10.9.200.18>
Call-ID: 2e5d5137707f09a824532e4b5104508e@10.9.200.54
Contact: <sip:2501@10.9.200.54:8575>
CSeq: 494 REGISTER
Max-Forwards: 70
Expires: 60
Allow: INVITE,CANCEL,ACK,BYE,NOTIFY,REFER,OPTIONS,INFO,MESSAGE,UPDATE
Authorization: Digest username="2501",realm="asterisk",nonce="3e415622",response="96baa94eb63ab4eb47604f60c8609f2a",uri="sip:10.9.200.18",algorithm=MD5
User-Agent: Intelbras (812240.0306.G3)
Content-Length: 0

<------------->
--- (13 headers 0 lines) ---
Sending to 10.9.200.54:8575 (NAT)
Reliably Transmitting (NAT) to 10.9.200.54:8575:
OPTIONS sip:2501@10.9.200.54:8575 SIP/2.0
Via: SIP/2.0/UDP 10.9.200.18:5060;branch=z9hG4bK1b63879f;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@10.9.200.18>;tag=as74d5c0b3
To: <sip:2501@10.9.200.54:8575>
Contact: <sip:Unknown@10.9.200.18:5060>
Call-ID: 78fcea5427d26add66c1529a5c7a4edf@10.9.200.18:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-2.8.1(1.8.10.0)
Date: Thu, 29 Mar 2012 13:58:24 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0


---

<--- Transmitting (NAT) to 10.9.200.54:8575 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.9.200.54:8575;branch=z9hG4bKb5b7b57aba;received=10.9.200.54;rport=8575
From: "2501" <sip:2501@10.9.200.18>;tag=081e2cb5
To: "2501" <sip:2501@10.9.200.18>;tag=as04bcac9e
Call-ID: 2e5d5137707f09a824532e4b5104508e@10.9.200.54
CSeq: 494 REGISTER
Server: FPBX-2.8.1(1.8.10.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Expires: 60
Contact: <sip:2501@10.9.200.54:8575>;expires=60
Date: Thu, 29 Mar 2012 13:58:24 GMT
Content-Length: 0


<------------>
Scheduling destruction of SIP dialog '2e5d5137707f09a824532e4b5104508e@10.9.200.54' in 32000 ms (Method: REGISTER)

<--- SIP read from UDP:10.9.200.54:8575 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.9.200.18:5060;rport=5060;received=10.9.200.18;branch=z9hG4bK1b63879f
From: "Unknown" <sip:Unknown@10.9.200.18>;tag=as74d5c0b3
To: <sip:2501@10.9.200.54:8575>;tag=0c6b02b3
Call-ID: 78fcea5427d26add66c1529a5c7a4edf@10.9.200.18:5060
Contact: <sip:2501@10.9.200.54:8575>
CSeq: 102 OPTIONS
Allow: INVITE,CANCEL,ACK,BYE,NOTIFY,REFER,OPTIONS
Content-Length: 0

<------------->
--- (9 headers 0 lines) ---
Really destroying SIP dialog '78fcea5427d26add66c1529a5c7a4edf@10.9.200.18:5060' Method: OPTIONS

<--- SIP read from UDP:10.9.122.15:5060 --->
OPTIONS sip:10.9.200.18 SIP/2.0
Via: SIP/2.0/UDP 10.9.122.15:5060;branch=z9hG4bK4a8f23a2;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@10.9.122.15>;tag=as628a0b8b
To: <sip:10.9.200.18>
Contact: <sip:Unknown@10.9.122.15>
Call-ID: 07c44e836374a1e74cc6730f455af752@10.9.122.15
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX 1.6.0.26-FONCORE-r78
Date: Thu, 29 Mar 2012 13:58:28 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces, timer
Content-Length: 0

<------------->
--- (13 headers 0 lines) ---
Looking for s in from-sip-external (domain 10.9.200.18)

<--- Transmitting (NAT) to 10.9.122.15:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.9.122.15:5060;branch=z9hG4bK4a8f23a2;received=10.9.122.15;rport=5060
From: "Unknown" <sip:Unknown@10.9.122.15>;tag=as628a0b8b
To: <sip:10.9.200.18>;tag=as190cefcf
Call-ID: 07c44e836374a1e74cc6730f455af752@10.9.122.15
CSeq: 102 OPTIONS
Server: FPBX-2.8.1(1.8.10.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:10.9.200.18:5060>
Accept: application/sdp
Content-Length: 0


<------------>
Scheduling destruction of SIP dialog '07c44e836374a1e74cc6730f455af752@10.9.122.15' in 32000 ms (Method: OPTIONS)



And here is a Working call Call with No PIN SET and DEBUG OFF:

-- Executing [10923640102@from-internal:1] Macro("SIP/2501-0000000a", "user-callerid,SKIPTTL,") in new stack
    -- Executing [s@macro-user-callerid:1] Set("SIP/2501-0000000a", "AMPUSER=2501") in new stack
    -- Executing [s@macro-user-callerid:2] GotoIf("SIP/2501-0000000a", "0?report") in new stack
    -- Executing [s@macro-user-callerid:3] ExecIf("SIP/2501-0000000a", "1?Set(REALCALLERIDNUM=2501)") in new stack
    -- Executing [s@macro-user-callerid:4] Set("SIP/2501-0000000a", "AMPUSER=2501") in new stack
    -- Executing [s@macro-user-callerid:5] Set("SIP/2501-0000000a", "AMPUSERCIDNAME=Ramal 2501") in new stack
    -- Executing [s@macro-user-callerid:6] GotoIf("SIP/2501-0000000a", "0?report") in new stack
    -- Executing [s@macro-user-callerid:7] Set("SIP/2501-0000000a", "AMPUSERCID=2501") in new stack
    -- Executing [s@macro-user-callerid:8] Set("SIP/2501-0000000a", "CALLERID(all)="Ramal 2501" <2501>") in new stack
    -- Executing [s@macro-user-callerid:9] ExecIf("SIP/2501-0000000a", "0?Set(CHANNEL(language)=)") in new stack
    -- Executing [s@macro-user-callerid:10] GotoIf("SIP/2501-0000000a", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,19)
    -- Executing [s@macro-user-callerid:19] Set("SIP/2501-0000000a", "CALLERID(number)=2501") in new stack
    -- Executing [s@macro-user-callerid:20] Set("SIP/2501-0000000a", "CALLERID(name)=Ramal 2501") in new stack
    -- Executing [s@macro-user-callerid:21] NoOp("SIP/2501-0000000a", "Using CallerID "Ramal 2501" <2501>") in new stack
    -- Executing [10923640102@from-internal:2] NoOp("SIP/2501-0000000a", "Calling Out Route: ANGOLA") in new stack
    -- Executing [10923640102@from-internal:3] Set("SIP/2501-0000000a", "MOH in new stack
    -- Executing [10923640102@from-internal:4] Set("SIP/2501-0000000a", "_NODEST=") in new stack
    -- Executing [10923640102@from-internal:5] Macro("SIP/2501-0000000a", "record-enable,2501,OUT,") in new stack
    -- Executing [s@macro-record-enable:1] GotoIf("SIP/2501-0000000a", "1?check") in new stack
    -- Goto (macro-record-enable,s,4)
    -- Executing [s@macro-record-enable:4] ExecIf("SIP/2501-0000000a", "0?MacroExit()") in new stack
    -- Executing [s@macro-record-enable:5] GotoIf("SIP/2501-0000000a", "0?Group:OUT") in new stack
    -- Goto (macro-record-enable,s,15)
    -- Executing [s@macro-record-enable:15] GotoIf("SIP/2501-0000000a", "0?IN") in new stack
    -- Executing [s@macro-record-enable:16] ExecIf("SIP/2501-0000000a", "1?MacroExit()") in new stack
    -- Executing [10923640102@from-internal:6] Macro("SIP/2501-0000000a", "dialout-trunk,2,10923640102,") in new stack
    -- Executing [s@macro-dialout-trunk:1] Set("SIP/2501-0000000a", "DIAL_TRUNK=2") in new stack
    -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/2501-0000000a", "0?sub-pincheck,s,1") in new stack
    -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/2501-0000000a", "0?disabletrunk,1") in new stack
    -- Executing [s@macro-dialout-trunk:4] Set("SIP/2501-0000000a", "DIAL_NUMBER=10923640102") in new stack
    -- Executing [s@macro-dialout-trunk:5] Set("SIP/2501-0000000a", "DIAL_TRUNK_OPTIONS=tr") in new stack
    -- Executing [s@macro-dialout-trunk:6] Set("SIP/2501-0000000a", "OUTBOUND_GROUP=OUT_2") in new stack
    -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/2501-0000000a", "0?nomax") in new stack
    -- Executing [s@macro-dialout-trunk:8] GotoIf("SIP/2501-0000000a", "0?chanfull") in new stack
    -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/2501-0000000a", "0?skipoutcid") in new stack
    -- Executing [s@macro-dialout-trunk:10] Set("SIP/2501-0000000a", "DIAL_TRUNK_OPTIONS=") in new stack
    -- Executing [s@macro-dialout-trunk:11] Macro("SIP/2501-0000000a", "outbound-callerid,2") in new stack
    -- Executing [s@macro-outbound-callerid:1] ExecIf("SIP/2501-0000000a", "0?Set(CALLERPRES()=)") in new stack
    -- Executing [s@macro-outbound-callerid:2] ExecIf("SIP/2501-0000000a", "0?Set(REALCALLERIDNUM=2501)") in new stack
    -- Executing [s@macro-outbound-callerid:3] GotoIf("SIP/2501-0000000a", "1?normcid") in new stack
    -- Goto (macro-outbound-callerid,s,6)
    -- Executing [s@macro-outbound-callerid:6] Set("SIP/2501-0000000a", "USEROUTCID=") in new stack
    -- Executing [s@macro-outbound-callerid:7] Set("SIP/2501-0000000a", "EMERGENCYCID=") in new stack
    -- Executing [s@macro-outbound-callerid:8] Set("SIP/2501-0000000a", "TRUNKOUTCID=") in new stack
    -- Executing [s@macro-outbound-callerid:9] GotoIf("SIP/2501-0000000a", "1?trunkcid") in new stack
    -- Goto (macro-outbound-callerid,s,12)
    -- Executing [s@macro-outbound-callerid:12] ExecIf("SIP/2501-0000000a", "0?Set(CALLERID(all)=)") in new stack
    -- Executing [s@macro-outbound-callerid:13] ExecIf("SIP/2501-0000000a", "0?Set(CALLERID(all)=)") in new stack
    -- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/2501-0000000a", "0?Set(CALLERID(all)=)") in new stack
    -- Executing [s@macro-outbound-callerid:15] ExecIf("SIP/2501-0000000a", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
    -- Executing [s@macro-dialout-trunk:12] GosubIf("SIP/2501-0000000a", "0?sub-flp-2,s,1") in new stack
    -- Executing [s@macro-dialout-trunk:13] Set("SIP/2501-0000000a", "OUTNUM=10923640102") in new stack
    -- Executing [s@macro-dialout-trunk:14] Set("SIP/2501-0000000a", "custom=SIP/UCM11") in new stack
    -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/2501-0000000a", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))") in new stack
    -- Executing [s@macro-dialout-trunk:16] Macro("SIP/2501-0000000a", "dialout-trunk-predial-hook,") in new stack
    -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/2501-0000000a", "") in new stack
    -- Executing [s@macro-dialout-trunk:17] GotoIf("SIP/2501-0000000a", "0?bypass,1") in new stack
    -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/2501-0000000a", "0?customtrunk") in new stack
    -- Executing [s@macro-dialout-trunk:19] Dial("SIP/2501-0000000a", "SIP/UCM11/10923640102,300,") in new stack
  == Using SIP RTP TOS bits 184
  == Using SIP RTP CoS mark 5
    -- Called SIP/UCM11/10923640102
    -- SIP/UCM11-0000000b is ringing
    -- SIP/UCM11-0000000b is making progress passing it to SIP/2501-0000000a
    -- SIP/UCM11-0000000b answered SIP/2501-0000000a
    -- Locally bridging SIP/2501-0000000a and SIP/UCM11-0000000b
    -- Executing [h@macro-dialout-trunk:1] Macro("SIP/2501-0000000a", "hangupcall,") in new stack
    -- Executing [s@macro-hangupcall:1] GotoIf("SIP/2501-0000000a", "1?endmixmoncheck") in new stack
    -- Goto (macro-hangupcall,s,9)
    -- Executing [s@macro-hangupcall:9] NoOp("SIP/2501-0000000a", "End of MIXMON check") in new stack
    -- Executing [s@macro-hangupcall:10] GotoIf("SIP/2501-0000000a", "1?nomeetmemon") in new stack
    -- Goto (macro-hangupcall,s,15)
    -- Executing [s@macro-hangupcall:15] NoOp("SIP/2501-0000000a", "MEETME_RECORDINGFILE=") in new stack
    -- Executing [s@macro-hangupcall:16] GotoIf("SIP/2501-0000000a", "1?noautomon") in new stack
    -- Goto (macro-hangupcall,s,18)
    -- Executing [s@macro-hangupcall:18] NoOp("SIP/2501-0000000a", "TOUCH_MONITOR_OUTPUT=") in new stack
    -- Executing [s@macro-hangupcall:19] GotoIf("SIP/2501-0000000a", "1?noautomon2") in new stack
    -- Goto (macro-hangupcall,s,25)
    -- Executing [s@macro-hangupcall:25] NoOp("SIP/2501-0000000a", "MONITOR_FILENAME=") in new stack
    -- Executing [s@macro-hangupcall:26] GotoIf("SIP/2501-0000000a", "1?skiprg") in new stack
    -- Goto (macro-hangupcall,s,29)
    -- Executing [s@macro-hangupcall:29] GotoIf("SIP/2501-0000000a", "1?skipblkvm") in new stack
    -- Goto (macro-hangupcall,s,32)
    -- Executing [s@macro-hangupcall:32] GotoIf("SIP/2501-0000000a", "1?theend") in new stack
    -- Goto (macro-hangupcall,s,34)
    -- Executing [s@macro-hangupcall:34] Hangup("SIP/2501-0000000a", "") in new stack
  == Spawn extension (macro-hangupcall, s, 34) exited non-zero on 'SIP/2501-0000000a' in macro 'hangupcall'
  == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'SIP/2501-0000000a'
  == Spawn extension (macro-dialout-trunk, s, 19) exited non-zero on 'SIP/2501-0000000a' in macro 'dialout-trunk'
  == Spawn extension (from-internal, 10923640102, 6) exited non-zero on 'SIP/2501-0000000a'

Any help would be really, really apreciated

Thank you all in advance