Problem forwarding external calls

Here is the situation.

I have Elastix installed on a HP DL360 G6 Xeon E5540 2.53GHz 1P/4C 6GB Memory 4SFF
(2.5) P410i/256 Model with a Digium TE121 on it.

There is a PRI line coming in so there are 23 channels.

Someone externally calls in to an extension, we will call this person EXTERNAL1. The extension, which we will call ASTERISK-EXT is set to forward to calls to another external number, like a cell phone or something, this will be called EXTERNAL2.

From EXTERNAL1 you hear a few rings, then it goes to the extenstion (ASTERISK-EXT) voicemail.

Attached is the debug information for when this occurs, i have replaced the numbers with EXTERNAL1, ASTERISK-EXT, and EXTERNAL2.

Please let me know if any more information is required, and what possible solutions to this may be. From looking through the debug info it seems that when the call is forwarded, it tries to go out the same channel.

Code:

-- Accepting call from 'EXTERNAL1' to 'ASTERISK-EXT' on channel 0/16, span 1 -- Executing [[email protected]:1] Set("DAHDI/16-1", "__FROM_DID=ASTERISK-EXT") in new stack -- Executing [[email protected]:2] Gosub("DAHDI/16-1", "app-blacklist-check|s|1") in new stack -- Executing [[email protected]:1] LookupBlacklist("DAHDI/16-1", "") in new stack -- Executing [[email protected]:2] GotoIf("DAHDI/16-1", "0?blacklisted") in new stack -- Executing [[email protected]:3] Set("DAHDI/16-1", "CALLED_BLACKLIST=1") in new stack -- Executing [[email protected]:4] Return("DAHDI/16-1", "") in new stack -- Executing [[email protected]:3] ExecIf("DAHDI/16-1", "1 |Set|CALLERID(name)=EXTERNAL1") in new stack -- Executing [[email protected]:4] Set("DAHDI/16-1", "__CALLINGPRES_SV=allowed") in new stack -- Executing [[email protected]:5] SetCallerPres("DAHDI/16-1", "allowed_not_screened") in new stack -- Executing [[email protected]:6] Goto("DAHDI/16-1", "from-did-direct|2028|1") in new stack -- Goto (from-did-direct,2028,1) -- Executing [[email protected]:1] Macro("DAHDI/16-1", "exten-vm|2028|2028") in new stack -- Executing [[email protected]:1] Macro("DAHDI/16-1", "user-callerid|") in new stack -- Executing [[email protected]:1] Set("DAHDI/16-1", "AMPUSER=EXTERNAL1") in new stack -- Executing [[email protected]:2] GotoIf("DAHDI/16-1", "0?report") in new stack -- Executing [[email protected]:3] ExecIf("DAHDI/16-1", "1|Set|REALCALLERIDNUM=EXTERNAL1") in new stack -- Executing [[email protected]:4] Set("DAHDI/16-1", "AMPUSER=") in new stack -- Executing [[email protected]:5] Set("DAHDI/16-1", "AMPUSERCIDNAME=") in new stack -- Executing [[email protected]:6] GotoIf("DAHDI/16-1", "1?report") in new stack -- Goto (macro-user-callerid,s,10) -- Executing [[email protected]:10] GotoIf("DAHDI/16-1", "0?continue") in new stack -- Executing [[email protected]:11] Set("DAHDI/16-1", "__TTL=64") in new stack -- Executing [[email protected]:12] GotoIf("DAHDI/16-1", "1?continue") in new stack -- Goto (macro-user-callerid,s,19) -- Executing [[email protected]:19] NoOp("DAHDI/16-1", "Using CallerID "EXTERNAL1" <EXTERNAL1>") in new stack -- Executing [[email protected]:2] Set("DAHDI/16-1", "RingGroupMethod=none") in new stack -- Executing [[email protected]:3] Set("DAHDI/16-1", "VMBOX=2028") in new stack -- Executing [[email protected]:4] Set("DAHDI/16-1", "EXTTOCALL=2028") in new stack -- Executing [[email protected]:5] Set("DAHDI/16-1", "CFUEXT=") in new stack -- Executing [[email protected]:6] Set("DAHDI/16-1", "CFBEXT=") in new stack -- Executing [[email protected]:7] Set("DAHDI/16-1", "RT=15") in new stack -- Executing [[email protected]:8] Macro("DAHDI/16-1", "record-enable|2028|IN") in new stack -- Executing [[email protected]:1] GotoIf("DAHDI/16-1", "1?check") in new stack -- Goto (macro-record-enable,s,4) -- Executing [[email protected]:4] ExecIf("DAHDI/16-1", "0|MacroExit|") in new stack -- Executing [[email protected]:5] GotoIf("DAHDI/16-1", "0?Group:OUT") in new stack -- Goto (macro-record-enable,s,15) -- Executing [[email protected]:15] GotoIf("DAHDI/16-1", "1?IN") in new stack -- Goto (macro-record-enable,s,20) -- Executing [[email protected]:20] ExecIf("DAHDI/16-1", "1|MacroExit|") in new stack -- Executing [[email protected]:9] Macro("DAHDI/16-1", "dial|15|trWw|2028") in new stack -- Executing [[email protected]:1] GotoIf("DAHDI/16-1", "1?dial") in new stack -- Goto (macro-dial,s,3) -- Executing [[email protected]:3] AGI("DAHDI/16-1", "dialparties.agi") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi dialparties.agi: Starting New Dialparties.agi == Parsing '/etc/asterisk/manager.conf': Found == Parsing '/etc/asterisk/manager_additional.conf': Found == Parsing '/etc/asterisk/manager_custom.conf': Found == Manager 'admin' logged on from 127.0.0.1 dialparties.agi: Caller ID name is 'EXTERNAL1' number is 'EXTERNAL1' dialparties.agi: USE_CONFIRMATION: 'FALSE' dialparties.agi: RINGGROUP_INDEX: '' dialparties.agi: Methodology of ring is 'none' -- dialparties.agi: Added extension 2028 to extension map > dialparties.agi: Extension 2028 has call screening off -- dialparties.agi: Extension 2028 cf is disabled -- dialparties.agi: Extension 2028 do not disturb is disabled > dialparties.agi: extnum 2028 has: cw: 0; hascfb: 0 [] hascfu: 0 [] dialparties.agi: ExtensionState: 0 dialparties.agi: Extension 2028 has ExtensionState: 0 -- dialparties.agi: Checking CW and CFB status for extension 2028 -- dialparties.agi: dbset CALLTRACE/2028 to EXTERNAL1 -- dialparties.agi: Filtered ARG3: 2028 == Manager 'admin' logged off from 127.0.0.1 -- AGI Script dialparties.agi completed, returning 0 -- Executing [[email protected]:7] Dial("DAHDI/16-1", "SIP/2028|15|trWw") in new stack -- Called 2028 -- Got SIP response 302 "Moved Temporarily" back from 10.253.250.21 -- Now forwarding DAHDI/16-1 to 'Local/[email protected]' (thanks to SIP/2028-08b8d108) -- Executing [[email protected]:1] Macro("Local/[email protected],2", "user-callerid|SKIPTTL|") in new stack -- Executing [[email protected]:1] Set("Local/[email protected],2", "AMPUSER=EXTERNAL1") in new stack -- Executing [[email protected]:2] GotoIf("Local/[email protected],2", "1?report") in new stack -- Goto (macro-user-callerid,s,10) -- Executing [[email protected]:10] GotoIf("Local/[email protected],2", "1?continue") in new stack -- Goto (macro-user-callerid,s,19) -- Executing [[email protected]:19] NoOp("Local/[email protected],2", "Using CallerID "EXTERNAL1" <EXTERNAL1>") in new stack -- Executing [[email protected]:2] Set("Local/[email protected],2", "_NODEST=") in new stack -- Executing [[email protected]:3] Macro("Local/[email protected],2", "record-enable|EXTERNAL1|OUT|") in new stack -- Executing [[email protected]:1] GotoIf("Local/[email protected],2", "1?check") in new stack -- Goto (macro-record-enable,s,4) -- Executing [[email protected]:4] ExecIf("Local/[email protected],2", "0|MacroExit|") in new stack -- Executing [[email protected]:5] GotoIf("Local/[email protected],2", "0?Group:OUT") in new stack -- Goto (macro-record-enable,s,15) -- Executing [[email protected]:15] GotoIf("Local/[email protected],2", "0?IN") in new stack -- Executing [[email protected]:16] ExecIf("Local/[email protected],2", "1|MacroExit|") in new stack -- Executing [[email protected]:4] Macro("Local/[email protected],2", "dialout-trunk|2|9099726636||") in new stack -- Executing [[email protected]:1] Set("Local/[email protected],2", "DIAL_TRUNK=2") in new stack -- Executing [[email protected]:2] GosubIf("Local/[email protected],2", "0?sub-pincheck|s|1") in new stack -- Executing [[email protected]:3] GotoIf("Local/[email protected],2", "0?disabletrunk|1") in new stack -- Executing [[email protected]:4] Set("Local/[email protected],2", "DIAL_NUMBER=9099726636") in new stack -- Executing [[email protected]:5] Set("Local/[email protected],2", "DIAL_TRUNK_OPTIONS=trWw") in new stack -- Executing [[email protected]:6] Set("Local/[email protected],2", "OUTBOUND_GROUP=OUT_2") in new stack -- Executing [[email protected]:7] GotoIf("Local/[email protected],2", "1?nomax") in new stack -- Goto (macro-dialout-trunk,s,9) -- Executing [[email protected]runk:9] GotoIf("Local/[email protected],2", "0?skipoutcid") in new stack -- Executing [[email protected]:10] Set("Local/[email protected],2", "DIAL_TRUNK_OPTIONS=Ww") in new stack -- Executing [[email protected]:11] Macro("Local/[email protected],2", "outbound-callerid|2") in new stack -- Executing [[email protected]:1] ExecIf("Local/[email protected],2", "1|SetCallerPres|allowed") in new stack -- Executing [[email protected]:2] ExecIf("Local/[email protected],2", "1|Set|REALCALLERIDNUM=EXTERNAL1") in new stack -- Executing [[email protected]:3] GotoIf("Local/[email protected],2", "0?normcid") in new stack -- Executing [[email protected]:4] Set("Local/[email protected],2", "USEROUTCID=EXTERNAL1") in new stack -- Executing [[email protected]:5] GotoIf("Local/[email protected],2", "1?bypass") in new stack -- Goto (macro-outbound-callerid,s,7) -- Executing [[email protected]:7] Set("Local/[email protected],2", "EMERGENCYCID=") in new stack -- Executing [[email protected]:8] Set("Local/[email protected],2", "TRUNKOUTCID=424202000") in new stack -- Executing [[email protected]:9] GotoIf("Local/[email protected],2", "1?trunkcid") in new stack -- Goto (macro-outbound-callerid,s,12) -- Executing [[email protected]:12] ExecIf("Local/[email protected],2", "1|Set|CALLERID(all)=424202000") in new stack -- Executing [[email protected]:13] ExecIf("Local/[email protected],2", "1|Set|CALLERID(all)=EXTERNAL1") in new stack -- Executing [[email protected]:14] ExecIf("Local/[email protected],2", "0|Set|CALLERID(all)=") in new stack -- Executing [[email protected]:15] ExecIf("Local/[email protected],2", "0|SetCallerPres|prohib_passed_screen") in new stack -- Executing [[email protected]:12] ExecIf("Local/[email protected],2", "1|AGI|fixlocalprefix") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix > fixlocalprefix: Using pattern . == fixlocalprefix: Dialpattern . matched. 9099726636 -> 9099726636 -- AGI Script fixlocalprefix completed, returning 0 -- Executing [[email protected]:13] Set("Local/[email protected],2", "OUTNUM=9099726636") in new stack -- Executing [[email protected]:14] Set("Local/[email protected],2", "custom=DAHDI/g0") in new stack -- Executing [[email protected]:15] ExecIf("Local/[email protected],2", "0|Set|DIAL_TRUNK_OPTIONS=M(setmusic^)Ww") in new stack -- Executing [[email protected]:16] Macro("Local/[email protected],2", "dialout-trunk-predial-hook|") in new stack -- Executing [[email protected]:1] MacroExit("Local/[email protected],2", "") in new stack -- Executing [[email protected]:17] GotoIf("Local/[email protected],2", "0?bypass|1") in new stack -- Executing [[email protected]:18] GotoIf("Local/[email protected],2", "0?customtrunk") in new stack -- Executing [[email protected]:19] Dial("Local/[email protected],2", "DAHDI/g0/9099726636|300|Ww") in new stack -- Requested transfer capability: 0x00 - SPEECH -- Called g0/9099726636 -- DAHDI/1-1 is proceeding passing it to Local/[email protected],2 -- Local/[email protected],1 is proceeding passing it to DAHDI/16-1 -- Channel 0/1, span 1 got hangup request, cause 7 -- Hungup 'DAHDI/1-1' == Everyone is busy/congested at this time (1:0/0/1) -- Executing [[email protected]:20] NoOp("Local/[email protected],2", "Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 7") in new stack -- Executing [[email protected]:21] Goto("Local/[email protected],2", "s-CHANUNAVAIL|1") in new stack -- Goto (macro-dialout-trunk,s-CHANUNAVAIL,1) -- Executing [[email protected]:1] Set("Local/[email protected],2", "RC=7") in new stack -- Executing [[email protected]:2] Goto("Local/[email protected],2", "7|1") in new stack -- Goto (macro-dialout-trunk,7,1) -- Executing [[email protected]:1] Goto("Local/[email protected],2", "continue|1") in new stack -- Goto (macro-dialout-trunk,continue,1) -- Executing [[email protected]:1] GotoIf("Local/[email protected],2", "1?noreport") in new stack -- Goto (macro-dialout-trunk,continue,3) -- Executing [[email protected]:3] NoOp("Local/[email protected],2", "TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 7 - failing through to other trunks") in new stack -- Executing [[email protected]:4] Set("Local/[email protected],2", "CALLERID(number)=EXTERNAL1") in new stack -- Executing [[email protected]:5] Macro("Local/[email protected],2", "outisbusy|") in new stack -- Executing [[email protected]:1] Progress("Local/[email protected],2", "") in new stack -- Local/[email protected],1 is making progress passing it to DAHDI/16-1 -- Executing [[email protected]:2] GotoIf("Local/[email protected],2", "0?emergency|1") in new stack -- Executing [[email protected]:3] GotoIf("Local/[email protected],2", "0?intracompany|1") in new stack -- Executing [[email protected]:4] Playback("Local/[email protected],2", "all-circuits-busy-now&pls-try-call-later| noanswer") in new stack -- <Local/[email protected],2> Playing 'all-circuits-busy-now' (language 'en') -- Stopped music on hold on DAHDI/15-1 -- Executing [[email protected]:1] Macro("SIP/2003-08b607b0<ZOMBIE>", "hangupcall") in new stack -- Executing [[email protected]:1] GotoIf("SIP/2003-08b607b0<ZOMBIE>", "1?skiprg") in new stack -- Goto (macro-hangupcall,s,4) -- Executing [[email protected]:4] GotoIf("SIP/2003-08b607b0<ZOMBIE>", "1?skipblkvm") in new stack -- Goto (macro-hangupcall,s,7) -- Executing [[email protected]:7] GotoIf("SIP/2003-08b607b0<ZOMBIE>", "1?theend") in new stack -- Goto (macro-hangupcall,s,9) -- Executing [[email protected]:9] Hangup("SIP/2003-08b607b0<ZOMBIE>", "") in new stack == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/2003-08b607b0<ZOMBIE>' in macro 'hangupcall' == Spawn h extension (macro-dial, h, 1) exited non-zero on 'SIP/2003-08b607b0<ZOMBIE>' == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/2003-08b607b0<ZOMBIE>' in macro 'dial' == Spawn extension (ext-group, 600, 23) exited non-zero on 'SIP/2003-08b607b0<ZOMBIE>' -- <Local/[email protected],2> Playing 'pls-try-call-later' (language 'en') -- Executing [[email protected]:5] Congestion("Local/[email protected],2", "20") in new stack -- Local/[email protected],1 is circuit-busy == Spawn extension (macro-outisbusy, s, 5) exited non-zero on 'Local/[email protected],2' in macro 'outisbusy' == Everyone is busy/congested at this time (1:0/1/0) == Spawn extension (from-internal, EXTERNAL2, 5) exited non-zero on 'Local/[email protected],2' -- Executing [[email protected]:1] Macro("Local/[email protected],2", "hangupcall") in new stack -- Executing [[email protected]:1] GotoIf("Local/[email protected],2", "1?skiprg") in new stack -- Goto (macro-hangupcall,s,4) -- Executing [[email protected]:4] GotoIf("Local/[email protected],2", "1?skipblkvm") in new stack -- Goto (macro-hangupcall,s,7) -- Executing [[email protected]:7] GotoIf("Local/[email protected],2", "1?theend") in new stack -- Goto (macro-hangupcall,s,9) -- Executing [[email protected]:9] Hangup("Local/[email protected],2", "") in new stack == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'Local/[email protected],2' in macro 'hangupcall' == Spawn extension (from-internal, s, 1) exited non-zero on 'Local/[email protected],2' -- Executing [[email protected]:8] Set("DAHDI/16-1", "DIALSTATUS=CONGESTION") in new stack -- Executing [[email protected]:9] GosubIf("DAHDI/16-1", "0?CONGESTION|1") in new stack -- Executing [[email protected]:10] GotoIf("DAHDI/16-1", "0?exit|return") in new stack -- Executing [[email protected]:11] Set("DAHDI/16-1", "SV_DIALSTATUS=CONGESTION") in new stack -- Executing [[email protected]:12] GosubIf("DAHDI/16-1", "0?docfu|1") in new stack -- Executing [[email protected]:13] GosubIf("DAHDI/16-1", "0?docfb|1") in new stack -- Executing [[email protected]:14] Set("DAHDI/16-1", "DIALSTATUS=CONGESTION") in new stack -- Executing [[email protected]:15] NoOp("DAHDI/16-1", "Voicemail is 2028") in new stack -- Executing [[email protected]:16] GotoIf("DAHDI/16-1", "0?s-CONGESTION|1") in new stack -- Executing [[email protected]:17] NoOp("DAHDI/16-1", "Sending to Voicemail box 2028") in new stack -- Executing [[email protected]:18] Macro("DAHDI/16-1", "vm|2028|CONGESTION|") in new stack -- Executing [[email protected]:1] Macro("DAHDI/16-1", "user-callerid|SKIPTTL") in new stack -- Executing [[email protected]:1] Set("DAHDI/16-1", "AMPUSER=EXTERNAL1") in new stack -- Executing [[email protected]:2] GotoIf("DAHDI/16-1", "0?report") in new stack -- Executing [[email protected]:3] ExecIf("DAHDI/16-1", "0|Set|REALCALLERIDNUM=EXTERNAL1") in new stack -- Executing [[email protected]:4] Set("DAHDI/16-1", "AMPUSER=") in new stack -- Executing [[email protected]:5] Set("DAHDI/16-1", "AMPUSERCIDNAME=") in new stack -- Executing [[email protected]:6] GotoIf("DAHDI/16-1", "1?report") in new stack -- Goto (macro-user-callerid,s,10) -- Executing [[email protected]:10] GotoIf("DAHDI/16-1", "1?continue") in new stack -- Goto (macro-user-callerid,s,19) -- Executing [[email protected]:19] NoOp("DAHDI/16-1", "Using CallerID "EXTERNAL1" <EXTERNAL1>") in new stack -- Executing [[email protected]:2] Set("DAHDI/16-1", "VMGAIN=""") in new stack -- Executing [[email protected]:3] GotoIf("DAHDI/16-1", "1?vmx|1") in new stack -- Goto (macro-vm,vmx,1) -- Executing [[email protected]:1] Set("DAHDI/16-1", "MEXTEN=2028") in new stack -- Executing [[email protected]:2] Set("DAHDI/16-1", "MMODE=CONGESTION") in new stack -- Executing [[email protected]:3] Set("DAHDI/16-1", "RETVM=") in new stack -- Executing [[email protected]:4] Set("DAHDI/16-1", "MODE=unavail") in new stack -- Executing [[email protected]:5] GotoIf("DAHDI/16-1", "1?chknomsg") in new stack -- Goto (macro-vm,vmx,7) -- Executing [[email protected]:7] GotoIf("DAHDI/16-1", "0?s-CONGESTION|1") in new stack -- Executing [[email protected]:8] GotoIf("DAHDI/16-1", "1?notdirect") in new stack -- Goto (macro-vm,vmx,10) -- Executing [[email protected]:10] NoOp("DAHDI/16-1", "Checking if ext 2028 is enabled: ") in new stack -- Executing [[email protected]:11] GotoIf("DAHDI/16-1", "1?s-CONGESTION|1") in new stack -- Goto (macro-vm,s-CONGESTION,1) -- Executing [[email protected]:1] Macro("DAHDI/16-1", "get-vmcontext|2028") in new stack -- Executing [[email protected]:1] Set("DAHDI/16-1", "VMCONTEXT=default") in new stack -- Executing [[email protected]:2] GotoIf("DAHDI/16-1", "0?200:300") in new stack -- Goto (macro-get-vmcontext,s,300) -- Executing [[email protected]:300] NoOp("DAHDI/16-1", "") in new stack -- Executing [[email protected]:2] VoiceMail("DAHDI/16-1", "[email protected]|u") in new stack -- <DAHDI/16-1> Playing 'vm-theperson' (language 'en')

Hey, did you ever find out the problem to this? i am having the same problem, pretty much the same log events, and can’t figure out why this is

( FreePBX 2.8.1.4 , Asterisk 1.8.13.0, Centos 5.5, i686)

Hi

I am having the same issue, did you luckily find a solution to the problem??

Thanks in advance