PSTN not working properly

robert_ovlg · February 3, 2012, 12:29am

Hi,

I have a Sangoma A200 board installed in my FreePBX system. Previously it was working fine but since a long time, I am trying to make it work again but getting undesired results.

What I want is -

The incoming calls on the PSTN line should go to IVR
Then on user’s selection of 0, it should ring the reception group.

What I am getting is -

PSTN call enters the system but doesn’t play the IVR at all.
Since it doesn’t play the IVR, no option has been given to the caller and the call directly hits the number set to Catch All.

I am trying to get it done since three weeks but no success till now. A help on this would really be appreciated.

Freepbx Version : 2.10
Asterisk Version : 1.8.7.1
Dahdi version : 2.5.0.2

CarolClark · February 3, 2012, 7:54pm

So it means that you are able to get the caller land in the dialplan. This is good and removes most of the troubleshooting. The only thing is to check your dialplan and extensions setting carefully along with the inspection of logs and most likely you will find the issue point. This situation could also be due to files missing or moved from their location. Post your settings and logs to let people here to be able to trace the issue point.

robert_ovlg · February 3, 2012, 8:24pm

Thanks for the answer. I was reading and found that I need to create a custom-destination to route the call as I want. For that I need to create a Custom Destination either from GUI or to be defined in extensions.conf. However, I don’t know how to create a custom destination. The codes are really driving me crazy. If I get to know how to do this, I can make it but anyway… till that time please hlp me out. I am sending the conf and logs…

CHAN_DAHDI.conf

[trunkgroups]

[channels]
context=from-pstn
usecallerid=yes
hidecallerid=no
callwaiting=yes
usecallingpres=yes
callwaitingcallerid=yes
threewaycalling=yes
transfer=yes
canpark=yes
cancallforward=yes
callreturn=yes
echocancel=yes
echocancelwhenbridged=yes
relaxdtmf=yes
rxgain=0.0
txgain=0.0
group=1
callgroup=1
pickupgroup=1
immediate=no
hanguponpolarityswitch=yes

;Sangoma AFT-A200 [slot:4 bus:2 span:1]
context=from-zaptel
group=0
echocancel=yes
signalling = fxs_ks
channel => 1

context=from-zaptel
group=0
echocancel=yes
signalling = fxs_ks
channel => 2

context=from-zaptel
group=0
echocancel=yes
signalling = fxs_ks
channel => 3

context=from-zaptel
group=0
echocancel=yes
signalling = fxs_ks
channel => 4

Extensions.conf

; Entry context for calls from the outside world to hit FreePBX
[from-pstn]
include => from-pstn-custom ; create this context in extensions_custom.conf to include customizations
include => ext-did
include => ext-did-post-custom
include => from-did-direct
include => ext-did-catchall ; THIS MUST COME AFTER ext-did

log

[2012-02-03 15:15:11] VERBOSE[3875] asterisk.c: – Remote UNIX connection
[2012-02-03 15:15:25] VERBOSE[14256] sig_analog.c: – Starting simple switch on ‘DAHDI/2-1’
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-zaptel:1] NoOp(“DAHDI/2-1”, "Entering from-dahdi with DID == ") in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-zaptel:2] Ringing(“DAHDI/2-1”, “”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-zaptel:3] Set(“DAHDI/2-1”, “DID=s”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-zaptel:4] NoOp(“DAHDI/2-1”, “DID is now s”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-zaptel:5] GotoIf(“DAHDI/2-1”, “1?dahdiok:checkzap”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Goto (from-zaptel,s,9)
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-zaptel:9] NoOp(“DAHDI/2-1”, “Is a DAHDi Channel”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-zaptel:10] Set(“DAHDI/2-1”, “CHAN=2-1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-zaptel:11] Set(“DAHDI/2-1”, “CHAN=2”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-zaptel:12] Macro(“DAHDI/2-1”, “from-dahdi-2,s,1”) in new stack
[2012-02-03 15:15:25] WARNING[14256] app_macro.c: No such context ‘macro-from-dahdi-2’ for macro ‘from-dahdi-2’
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-zaptel:13] NoOp(“DAHDI/2-1”, “Returned from Macro from-dahdi-2”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-zaptel:14] Goto(“DAHDI/2-1”, “from-pstn,s,1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Goto (from-pstn,s,1)
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-pstn:1] Set(“DAHDI/2-1”, “__FROM_DID=s”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-pstn:2] Gosub(“DAHDI/2-1”, “app-blacklist-check,s,1()”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@app-blacklist-check:1] GotoIf(“DAHDI/2-1”, “0?blacklisted”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@app-blacklist-check:2] Set(“DAHDI/2-1”, “CALLED_BLACKLIST=1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@app-blacklist-check:3] Return(“DAHDI/2-1”, “”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-pstn:3] Set(“DAHDI/2-1”, “CDR(did)=s”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-pstn:4] ExecIf(“DAHDI/2-1”, “1 ?Set(CALLERID(name)=)”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-pstn:5] Set(“DAHDI/2-1”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-pstn:6] Set(“DAHDI/2-1”, “CALLERPRES()=allowed_not_screened”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@from-pstn:7] Goto(“DAHDI/2-1”, “from-did-direct,8170,1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Goto (from-did-direct,8170,1)
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:1] GotoIf(“DAHDI/2-1”, “0?ext-local,8170,1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:2] Macro(“DAHDI/2-1”, “user-callerid,”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-user-callerid:1] Set(“DAHDI/2-1”, “AMPUSER=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-user-callerid:2] GotoIf(“DAHDI/2-1”, “0?report”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-user-callerid:3] ExecIf(“DAHDI/2-1”, “1?Set(REALCALLERIDNUM=)”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-user-callerid:4] Set(“DAHDI/2-1”, “AMPUSER=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-user-callerid:5] Set(“DAHDI/2-1”, “AMPUSERCIDNAME=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“DAHDI/2-1”, “1?report”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Goto (macro-user-callerid,s,13)
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-user-callerid:13] GotoIf(“DAHDI/2-1”, “0?continue”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-user-callerid:14] Set(“DAHDI/2-1”, “__TTL=64”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-user-callerid:15] GotoIf(“DAHDI/2-1”, “1?continue”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Goto (macro-user-callerid,s,26)
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-user-callerid:26] Set(“DAHDI/2-1”, “CALLERID(number)=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-user-callerid:27] Set(“DAHDI/2-1”, “CALLERID(name)=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-user-callerid:28] Set(“DAHDI/2-1”, “CHANNEL(language)=en”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:3] Set(“DAHDI/2-1”, “__EXTTOCALL=8170”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:4] Set(“DAHDI/2-1”, “__PICKUPMARK=8170”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:5] Macro(“DAHDI/2-1”, “blkvm-setifempty,”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-blkvm-setifempty:1] GotoIf(“DAHDI/2-1”, “1?init”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Goto (macro-blkvm-setifempty,s,4)
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-blkvm-setifempty:4] Set(“DAHDI/2-1”, “__BLKVM_CHANNEL=DAHDI/2-1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-blkvm-setifempty:5] Set(“DAHDI/2-1”, “SHARED(BLKVM,DAHDI/2-1)=TRUE”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-blkvm-setifempty:6] Set(“DAHDI/2-1”, “GOSUB_RETVAL=TRUE”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-blkvm-setifempty:7] MacroExit(“DAHDI/2-1”, “”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:6] GotoIf(“DAHDI/2-1”, “1?skipov”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Goto (from-did-direct,8170,9)
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:9] Set(“DAHDI/2-1”, “RRNODEST=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:10] Set(“DAHDI/2-1”, “__NODEST=8170”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:11] GosubIf(“DAHDI/2-1”, “0?sub-fmsetcid,s,1()”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:12] Set(“DAHDI/2-1”, “RecordMethod=Group”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:13] Gosub(“DAHDI/2-1”, “sub-record-check,s,1(exten,8170,)”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“DAHDI/2-1”, “1?check”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Goto (sub-record-check,s,3)
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:3] Set(“DAHDI/2-1”, “MON_FMT=wav”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:4] GotoIf(“DAHDI/2-1”, “1?next”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Goto (sub-record-check,s,7)
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:7] ExecIf(“DAHDI/2-1”, “0?Return()”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:8] GotoIf(“DAHDI/2-1”, “0?exten,1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:9] Set(“DAHDI/2-1”, “__REC_STATUS=INITIALIZED”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:10] ExecIf(“DAHDI/2-1”, “0?Set(__REC_POLICY_MODE=)”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:11] Set(“DAHDI/2-1”, “NOW=1328300125”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:12] Set(“DAHDI/2-1”, “__DAY=03”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:13] Set(“DAHDI/2-1”, “__MONTH=02”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:14] Set(“DAHDI/2-1”, “__YEAR=2012”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:15] Set(“DAHDI/2-1”, “__TIMESTR=20120203-151525”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:16] Set(“DAHDI/2-1”, “__FROMEXTEN=unknown”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:17] Set(“DAHDI/2-1”, “__CALLFILENAME=exten-8170-unknown-20120203-151525-1328300125.93”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@sub-record-check:18] Goto(“DAHDI/2-1”, “exten,1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Goto (sub-record-check,exten,1)
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [exten@sub-record-check:1] GotoIf(“DAHDI/2-1”, “0?callee”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [exten@sub-record-check:2] Set(“DAHDI/2-1”, “__REC_POLICY_MODE=always”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [exten@sub-record-check:3] GotoIf(“DAHDI/2-1”, “0?caller”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [exten@sub-record-check:4] GotoIf(“DAHDI/2-1”, “1?callee”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Goto (sub-record-check,exten,8)
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [exten@sub-record-check:8] GosubIf(“DAHDI/2-1”, “1?record,1(exten,8170,unknown)”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [record@sub-record-check:1] Set(“DAHDI/2-1”, “AUDIOHOOK_INHERIT(MixMonitor)=yes”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [record@sub-record-check:2] MixMonitor(“DAHDI/2-1”, “2012/02/03/exten-8170-unknown-20120203-151525-1328300125.93.wav,”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [record@sub-record-check:3] Set(“DAHDI/2-1”, “__REC_STATUS=RECORDING”) in new stack
[2012-02-03 15:15:25] VERBOSE[14257] app_mixmonitor.c: == Begin MixMonitor Recording DAHDI/2-1
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [record@sub-record-check:4] Set(“DAHDI/2-1”, “CDR(recordingfile)=exten-8170-unknown-20120203-151525-1328300125.93.wav”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [record@sub-record-check:5] Return(“DAHDI/2-1”, “”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [exten@sub-record-check:9] Return(“DAHDI/2-1”, “”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:14] Set(“DAHDI/2-1”, “RingGroupMethod=ringallv2”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:15] Set(“DAHDI/2-1”, “_FMGRP=8170”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:16] GotoIf(“DAHDI/2-1”, “0?doconfirm”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [8170@from-did-direct:17] Macro(“DAHDI/2-1”, “dial,30,tr,8170-99933456840#”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-dial:1] GotoIf(“DAHDI/2-1”, “1?dial”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Goto (macro-dial,s,3)
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-dial:3] AGI(“DAHDI/2-1”, “dialparties.agi”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] res_agi.c: – Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[2012-02-03 15:15:25] VERBOSE[14256] res_agi.c: dialparties.agi: Starting New Dialparties.agi
[2012-02-03 15:15:25] VERBOSE[14256] res_agi.c: dialparties.agi: Caller ID name is ‘unknown’ number is ‘unknown’
[2012-02-03 15:15:25] VERBOSE[14256] res_agi.c: dialparties.agi: Methodology of ring is ‘ringallv2’
[2012-02-03 15:15:25] VERBOSE[14256] res_agi.c: – dialparties.agi: Added extension 8170 to extension map
[2012-02-03 15:15:25] VERBOSE[14256] res_agi.c: – dialparties.agi: Added extension 99933456840# to extension map
[2012-02-03 15:15:25] VERBOSE[14256] res_agi.c: – dialparties.agi: Extension 8170 cf is disabled
[2012-02-03 15:15:25] VERBOSE[14256] res_agi.c: – dialparties.agi: Extension 99933456840# cf is disabled
[2012-02-03 15:15:25] VERBOSE[14256] res_agi.c: – dialparties.agi: Extension 8170 do not disturb is disabled
[2012-02-03 15:15:25] VERBOSE[14256] res_agi.c: – dialparties.agi: DbDel CALLTRACE/8170 - Caller ID is not defined
[2012-02-03 15:15:25] VERBOSE[14256] res_agi.c: – dialparties.agi: Filtered ARG3: 8170-99933456840
[2012-02-03 15:15:25] VERBOSE[14256] res_agi.c: – <DAHDI/2-1>AGI Script dialparties.agi completed, returning 0
[2012-02-03 15:15:25] VERBOSE[14256] pbx.c: – Executing [s@macro-dial:7] Dial(“DAHDI/2-1”, “Local/FMPR-8170@from-internal&Local/FMGL-99933456840#@from-internal,32,trM(auto-blkvm)”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] app_dial.c: – Called Local/FMPR-8170@from-internal
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [FMPR-8170@from-internal:1] NoCDR(“Local/FMPR-8170@from-internal-2b83;2”, “”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [FMPR-8170@from-internal:2] Set(“Local/FMPR-8170@from-internal-2b83;2”, “RingGroupMethod=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [FMPR-8170@from-internal:3] Set(“Local/FMPR-8170@from-internal-2b83;2”, “USE_CONFIRMATION=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [FMPR-8170@from-internal:4] Set(“Local/FMPR-8170@from-internal-2b83;2”, “RINGGROUP_INDEX=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14256] app_dial.c: – Called Local/FMGL-99933456840#@from-internal
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [FMPR-8170@from-internal:5] Macro(“Local/FMPR-8170@from-internal-2b83;2”, “simple-dial,8170,32”) in new stack
[2012-02-03 15:15:25] VERBOSE[14260] pbx.c: – Executing [FMGL-99933456840#@from-internal:1] NoCDR(“Local/FMGL-99933456840#@from-internal-9a10;2”, “”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-simple-dial:1] Set(“Local/FMPR-8170@from-internal-2b83;2”, “__EXTTOCALL=8170”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-simple-dial:2] Set(“Local/FMPR-8170@from-internal-2b83;2”, “RT=32”) in new stack
[2012-02-03 15:15:25] VERBOSE[14260] pbx.c: – Executing [FMGL-99933456840#@from-internal:2] Set(“Local/FMGL-99933456840#@from-internal-9a10;2”, “ENDLOOP=1328300127”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-simple-dial:3] Set(“Local/FMPR-8170@from-internal-2b83;2”, “CFUEXT=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-simple-dial:4] Set(“Local/FMPR-8170@from-internal-2b83;2”, “CFBEXT=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14260] pbx.c: – Executing [FMGL-99933456840#@from-internal:3] GotoIf(“Local/FMGL-99933456840#@from-internal-9a10;2”, “0?dodnd”) in new stack
[2012-02-03 15:15:25] VERBOSE[14260] pbx.c: – Executing [FMGL-99933456840#@from-internal:4] Wait(“Local/FMGL-99933456840#@from-internal-9a10;2”, “1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-simple-dial:5] Set(“Local/FMPR-8170@from-internal-2b83;2”, “CWI_TMP=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-simple-dial:6] Macro(“Local/FMPR-8170@from-internal-2b83;2”, “dial-one,32,tr,8170”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:1] Set(“Local/FMPR-8170@from-internal-2b83;2”, “DEXTEN=8170”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:2] Set(“Local/FMPR-8170@from-internal-2b83;2”, “DIALSTATUS_CW=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:3] GosubIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?screen,1()”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:4] GosubIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?cf,1()”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:5] GotoIf(“Local/FMPR-8170@from-internal-2b83;2”, “1?skip1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Goto (macro-dial-one,s,8)
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:8] GotoIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?nodial”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:9] GotoIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?continue”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:10] Set(“Local/FMPR-8170@from-internal-2b83;2”, “EXTHASCW=ENABLED”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:11] GotoIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?next1:cwinusebusy”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Goto (macro-dial-one,s,23)
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:23] GotoIf(“Local/FMPR-8170@from-internal-2b83;2”, “1?next3:continue”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Goto (macro-dial-one,s,24)
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:24] ExecIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?Set(DIALSTATUS_CW=BUSY)”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:25] GotoIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?nodial”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:26] GosubIf(“Local/FMPR-8170@from-internal-2b83;2”, “1?dstring,1():dlocal,1()”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:1] Set(“Local/FMPR-8170@from-internal-2b83;2”, “DSTRING=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:2] Set(“Local/FMPR-8170@from-internal-2b83;2”, “DEVICES=8170”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:3] ExecIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?Return()”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:4] ExecIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?Set(DEVICES=170)”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:5] Set(“Local/FMPR-8170@from-internal-2b83;2”, “LOOPCNT=1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:6] Set(“Local/FMPR-8170@from-internal-2b83;2”, “ITER=1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:7] Set(“Local/FMPR-8170@from-internal-2b83;2”, “THISDIAL=SIP/8170”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:8] GosubIf(“Local/FMPR-8170@from-internal-2b83;2”, “1?zap2dahdi,1()”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [zap2dahdi@macro-dial-one:1] ExecIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?Return()”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [zap2dahdi@macro-dial-one:2] Set(“Local/FMPR-8170@from-internal-2b83;2”, “NEWDIAL=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [zap2dahdi@macro-dial-one:3] Set(“Local/FMPR-8170@from-internal-2b83;2”, “LOOPCNT2=1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [zap2dahdi@macro-dial-one:4] Set(“Local/FMPR-8170@from-internal-2b83;2”, “ITER2=1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [zap2dahdi@macro-dial-one:5] Set(“Local/FMPR-8170@from-internal-2b83;2”, “THISPART2=SIP/8170”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [zap2dahdi@macro-dial-one:6] ExecIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?Set(THISPART2=DAHDI/8170)”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [zap2dahdi@macro-dial-one:7] Set(“Local/FMPR-8170@from-internal-2b83;2”, “NEWDIAL=SIP/8170&”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [zap2dahdi@macro-dial-one:8] Set(“Local/FMPR-8170@from-internal-2b83;2”, “ITER2=2”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [zap2dahdi@macro-dial-one:9] GotoIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?begin2”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [zap2dahdi@macro-dial-one:10] Set(“Local/FMPR-8170@from-internal-2b83;2”, “THISDIAL=SIP/8170”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [zap2dahdi@macro-dial-one:11] Return(“Local/FMPR-8170@from-internal-2b83;2”, “”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:9] Set(“Local/FMPR-8170@from-internal-2b83;2”, “DSTRING=SIP/8170&”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:10] Set(“Local/FMPR-8170@from-internal-2b83;2”, “ITER=2”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:11] GotoIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?begin”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:12] Set(“Local/FMPR-8170@from-internal-2b83;2”, “DSTRING=SIP/8170”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [dstring@macro-dial-one:13] Return(“Local/FMPR-8170@from-internal-2b83;2”, “”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:27] GotoIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?nodial”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:28] GotoIf(“Local/FMPR-8170@from-internal-2b83;2”, “1?skiptrace”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Goto (macro-dial-one,s,30)
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:30] Set(“Local/FMPR-8170@from-internal-2b83;2”, “D_OPTIONS=trM(auto-blkvm)”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:31] ExecIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?SIPAddHeader(Alert-Info: )”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:32] ExecIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?SIPAddHeader()”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:33] ExecIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?Set(CHANNEL(musicclass)=)”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:34] GosubIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?qwait,1()”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:35] Set(“Local/FMPR-8170@from-internal-2b83;2”, “__CWIGNORE=”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:36] Set(“Local/FMPR-8170@from-internal-2b83;2”, “__KEEPCID=TRUE”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:37] GotoIf(“Local/FMPR-8170@from-internal-2b83;2”, “0?usegoto,1”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:38] GotoIf(“Local/FMPR-8170@from-internal-2b83;2”, “1?godial”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Goto (macro-dial-one,s,42)
[2012-02-03 15:15:25] VERBOSE[14259] pbx.c: – Executing [s@macro-dial-one:42] Dial(“Local/FMPR-8170@from-internal-2b83;2”, “SIP/8170,32,trM(auto-blkvm)”) in new stack
[2012-02-03 15:15:25] VERBOSE[14259] netsock2.c: == Using SIP RTP TOS bits 184
[2012-02-03 15:15:25] VERBOSE[14259] netsock2.c: == Using SIP RTP CoS mark 5
[2012-02-03 15:15:25] VERBOSE[14259] app_dial.c: – Called SIP/8170
[2012-02-03 15:15:25] VERBOSE[14256] app_dial.c: – Local/FMPR-8170@from-internal-2b83;1 is ringing
[2012-02-03 15:15:25] VERBOSE[14256] app_dial.c: – Local/FMPR-8170@from-internal-2b83;1 connected line has changed. Saving it until answer for DAHDI/2-1
[2012-02-03 15:15:25] VERBOSE[14256] app_dial.c: – Local/FMPR-8170@from-internal-2b83;1 connected line has changed. Saving it until answer for DAHDI/2-1
[2012-02-03 15:15:25] VERBOSE[14259] app_dial.c: – SIP/8170-00000008 is ringing
[2012-02-03 15:15:25] VERBOSE[14256] app_dial.c: – Local/FMPR-8170@from-internal-2b83;1 is ringing
[2012-02-03 15:15:26] VERBOSE[14260] pbx.c: – Executing [FMGL-99933456840#@from-internal:5] GotoIf(“Local/FMGL-99933456840#@from-internal-9a10;2”, “1?start”) in new stack
[2012-02-03 15:15:26] VERBOSE[14260] pbx.c: – Goto (from-internal,FMGL-99933456840#,3)
[2012-02-03 15:15:26] VERBOSE[14260] pbx.c: – Executing [FMGL-99933456840#@from-internal:3] GotoIf(“Local/FMGL-99933456840#@from-internal-9a10;2”, “0?dodnd”) in new stack
[2012-02-03 15:15:26] VERBOSE[14260] pbx.c: – Executing [FMGL-99933456840#@from-internal:4] Wait(“Local/FMGL-99933456840#@from-internal-9a10;2”, “1”) in new stack
[2012-02-03 15:15:27] VERBOSE[14260] pbx.c: – Executing [FMGL-99933456840#@from-internal:5] GotoIf(“Local/FMGL-99933456840#@from-internal-9a10;2”, “0?start”) in new stack
[2012-02-03 15:15:27] VERBOSE[14260] pbx.c: – Executing [FMGL-99933456840#@from-internal:6] Set(“Local/FMGL-99933456840#@from-internal-9a10;2”, “SHARED(FM_DND,DAHDI/2-1)=”) in new stack
[2012-02-03 15:15:27] VERBOSE[14260] pbx.c: – Executing [FMGL-99933456840#@from-internal:7] Macro(“Local/FMGL-99933456840#@from-internal-9a10;2”, “dial,30,tr,99933456840#”) in new stack
[2012-02-03 15:15:27] VERBOSE[14260] pbx.c: – Executing [s@macro-dial:1] GotoIf(“Local/FMGL-99933456840#@from-internal-9a10;2”, “1?dial”) in new stack
[2012-02-03 15:15:27] VERBOSE[14260] pbx.c: – Goto (macro-dial,s,3)
[2012-02-03 15:15:27] VERBOSE[14260] pbx.c: – Executing [s@macro-dial:3] AGI(“Local/FMGL-99933456840#@from-internal-9a10;2”, “dialparties.agi”) in new stack
[2012-02-03 15:15:27] VERBOSE[14260] res_agi.c: – Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[2012-02-03 15:15:28] VERBOSE[14260] res_agi.c: dialparties.agi: Starting New Dialparties.agi
[2012-02-03 15:15:28] VERBOSE[14260] res_agi.c: dialparties.agi: Caller ID name is ‘unknown’ number is ‘unknown’
[2012-02-03 15:15:28] VERBOSE[14260] res_agi.c: dialparties.agi: Methodology of ring is ‘ringall’
[2012-02-03 15:15:28] VERBOSE[14260] res_agi.c: – dialparties.agi: Added extension 99933456840# to extension map
[2012-02-03 15:15:28] VERBOSE[14260] res_agi.c: – dialparties.agi: Extension 99933456840# cf is disabled
[2012-02-03 15:15:28] VERBOSE[14260] res_agi.c: – dialparties.agi: Filtered ARG3: 99933456840
[2012-02-03 15:15:28] VERBOSE[14260] res_agi.c: – <Local/FMGL-99933456840#@from-internal-9a10;2>AGI Script dialparties.agi completed, returning 0
[2012-02-03 15:15:28] VERBOSE[14260] pbx.c: – Executing [s@macro-dial:7] Dial(“Local/FMGL-99933456840#@from-internal-9a10;2”, “Local/99933456840@from-internal/n,30,trM(auto-blkvm)”) in new stack
[2012-02-03 15:15:28] VERBOSE[14260] app_dial.c: – Called Local/99933456840@from-internal/n
[2012-02-03 15:15:28] VERBOSE[14256] app_dial.c: – Local/FMGL-99933456840#@from-internal-9a10;1 is ringing
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [99933456840@from-internal:1] Macro(“Local/99933456840@from-internal-1b40;2”, “user-callerid,LIMIT,”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-user-callerid:1] Set(“Local/99933456840@from-internal-1b40;2”, “AMPUSER=”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-user-callerid:2] GotoIf(“Local/99933456840@from-internal-1b40;2”, “1?report”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Goto (macro-user-callerid,s,13)
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-user-callerid:13] GotoIf(“Local/99933456840@from-internal-1b40;2”, “1?continue”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Goto (macro-user-callerid,s,26)
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-user-callerid:26] Set(“Local/99933456840@from-internal-1b40;2”, “CALLERID(number)=”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-user-callerid:27] Set(“Local/99933456840@from-internal-1b40;2”, “CALLERID(name)=”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-user-callerid:28] Set(“Local/99933456840@from-internal-1b40;2”, “CHANNEL(language)=en”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [99933456840@from-internal:2] Set(“Local/99933456840@from-internal-1b40;2”, “MOHCLASS=default”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [99933456840@from-internal:3] Set(“Local/99933456840@from-internal-1b40;2”, “_NODEST=”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [99933456840@from-internal:4] Gosub(“Local/99933456840@from-internal-1b40;2”, “sub-record-check,s,1(out,99933456840,)”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“Local/99933456840@from-internal-1b40;2”, “1?check”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Goto (sub-record-check,s,3)
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@sub-record-check:3] Set(“Local/99933456840@from-internal-1b40;2”, “MON_FMT=wav”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@sub-record-check:4] GotoIf(“Local/99933456840@from-internal-1b40;2”, “0?next”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@sub-record-check:5] Set(“Local/99933456840@from-internal-1b40;2”, “CDR(recordingfile)=exten-8170-unknown-20120203-151525-1328300125.93.wav”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@sub-record-check:6] Return(“Local/99933456840@from-internal-1b40;2”, “”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [99933456840@from-internal:5] Macro(“Local/99933456840@from-internal-1b40;2”, “dialout-trunk,1,9933456840,”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:1] Set(“Local/99933456840@from-internal-1b40;2”, “DIAL_TRUNK=1”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:2] GosubIf(“Local/99933456840@from-internal-1b40;2”, “0?sub-pincheck,s,1()”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:3] GotoIf(“Local/99933456840@from-internal-1b40;2”, “0?disabletrunk,1”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:4] Set(“Local/99933456840@from-internal-1b40;2”, “DIAL_NUMBER=9933456840”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:5] Set(“Local/99933456840@from-internal-1b40;2”, “DIAL_TRUNK_OPTIONS=tr”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:6] Set(“Local/99933456840@from-internal-1b40;2”, “OUTBOUND_GROUP=OUT_1”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:7] GotoIf(“Local/99933456840@from-internal-1b40;2”, “1?nomax”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Goto (macro-dialout-trunk,s,9)
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:9] GotoIf(“Local/99933456840@from-internal-1b40;2”, “0?skipoutcid”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:10] Set(“Local/99933456840@from-internal-1b40;2”, “DIAL_TRUNK_OPTIONS=”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:11] Macro(“Local/99933456840@from-internal-1b40;2”, “outbound-callerid,1”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outbound-callerid:1] ExecIf(“Local/99933456840@from-internal-1b40;2”, “1?Set(CALLERPRES()=allowed_not_screened)”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outbound-callerid:2] ExecIf(“Local/99933456840@from-internal-1b40;2”, “1?Set(REALCALLERIDNUM=)”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outbound-callerid:3] GotoIf(“Local/99933456840@from-internal-1b40;2”, “1?normcid”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Goto (macro-outbound-callerid,s,6)
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outbound-callerid:6] Set(“Local/99933456840@from-internal-1b40;2”, “USEROUTCID=”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outbound-callerid:7] Set(“Local/99933456840@from-internal-1b40;2”, “EMERGENCYCID=”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outbound-callerid:8] Set(“Local/99933456840@from-internal-1b40;2”, “TRUNKOUTCID=23370151”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outbound-callerid:9] GotoIf(“Local/99933456840@from-internal-1b40;2”, “1?trunkcid”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Goto (macro-outbound-callerid,s,12)
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outbound-callerid:12] ExecIf(“Local/99933456840@from-internal-1b40;2”, “1?Set(CALLERID(all)=23370151)”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outbound-callerid:13] ExecIf(“Local/99933456840@from-internal-1b40;2”, “0?Set(CALLERID(all)=)”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outbound-callerid:14] ExecIf(“Local/99933456840@from-internal-1b40;2”, “0?Set(CALLERID(all)=)”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outbound-callerid:15] ExecIf(“Local/99933456840@from-internal-1b40;2”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:12] GosubIf(“Local/99933456840@from-internal-1b40;2”, “0?sub-flp-1,s,1()”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:13] Set(“Local/99933456840@from-internal-1b40;2”, “OUTNUM=9933456840”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:14] Set(“Local/99933456840@from-internal-1b40;2”, “custom=DAHDI/g0”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:15] ExecIf(“Local/99933456840@from-internal-1b40;2”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:16] ExecIf(“Local/99933456840@from-internal-1b40;2”, “0?Set(DIAL_TRUNK_OPTIONS=M(confirm))”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:17] Macro(“Local/99933456840@from-internal-1b40;2”, “dialout-trunk-predial-hook,”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“Local/99933456840@from-internal-1b40;2”, “”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:18] GotoIf(“Local/99933456840@from-internal-1b40;2”, “0?bypass,1”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:19] ExecIf(“Local/99933456840@from-internal-1b40;2”, “0?Set(CONNECTEDLINE(num,i)=9933456840)”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:20] ExecIf(“Local/99933456840@from-internal-1b40;2”, “0?Set(CONNECTEDLINE(name,i)=CID:23370151)”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:21] GotoIf(“Local/99933456840@from-internal-1b40;2”, “0?customtrunk”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:22] Dial(“Local/99933456840@from-internal-1b40;2”, “DAHDI/g0/9933456840,300,”) in new stack
[2012-02-03 15:15:28] WARNING[14262] app_dial.c: Unable to create channel of type ‘DAHDI’ (cause 34 - Circuit/channel congestion)
[2012-02-03 15:15:28] VERBOSE[14262] app_dial.c: == Everyone is busy/congested at this time (1:0/1/0)
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:23] NoOp(“Local/99933456840@from-internal-1b40;2”, “Dial failed for some reason with DIALSTATUS = CONGESTION and HANGUPCAUSE = 34”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-dialout-trunk:24] Goto(“Local/99933456840@from-internal-1b40;2”, “s-CONGESTION,1”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Goto (macro-dialout-trunk,s-CONGESTION,1)
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s-CONGESTION@macro-dialout-trunk:1] Set(“Local/99933456840@from-internal-1b40;2”, “RC=34”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s-CONGESTION@macro-dialout-trunk:2] Goto(“Local/99933456840@from-internal-1b40;2”, “34,1”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Goto (macro-dialout-trunk,34,1)
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [34@macro-dialout-trunk:1] Goto(“Local/99933456840@from-internal-1b40;2”, “continue,1”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Goto (macro-dialout-trunk,continue,1)
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [continue@macro-dialout-trunk:1] GotoIf(“Local/99933456840@from-internal-1b40;2”, “1?noreport”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Goto (macro-dialout-trunk,continue,3)
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [continue@macro-dialout-trunk:3] NoOp(“Local/99933456840@from-internal-1b40;2”, “TRUNK Dial failed due to CONGESTION HANGUPCAUSE: 34 - failing through to other trunks”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [continue@macro-dialout-trunk:4] Set(“Local/99933456840@from-internal-1b40;2”, “CALLERID(number)=”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [99933456840@from-internal:6] Macro(“Local/99933456840@from-internal-1b40;2”, “outisbusy,”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outisbusy:1] Progress(“Local/99933456840@from-internal-1b40;2”, “”) in new stack
[2012-02-03 15:15:28] VERBOSE[14260] app_dial.c: – Local/99933456840@from-internal-1b40;1 is making progress passing it to Local/FMGL-99933456840#@from-internal-9a10;2
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outisbusy:2] GotoIf(“Local/99933456840@from-internal-1b40;2”, “0?emergency,1”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outisbusy:3] GotoIf(“Local/99933456840@from-internal-1b40;2”, “0?intracompany,1”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] pbx.c: – Executing [s@macro-outisbusy:4] Playback(“Local/99933456840@from-internal-1b40;2”, “all-circuits-busy-now&pls-try-call-later, noanswer”) in new stack
[2012-02-03 15:15:28] VERBOSE[14262] file.c: – <Local/99933456840@from-internal-1b40;2> Playing ‘all-circuits-busy-now.ulaw’ (language ‘en’)
[2012-02-03 15:15:29] VERBOSE[14262] file.c: – <Local/99933456840@from-internal-1b40;2> Playing ‘pls-try-call-later.ulaw’ (language ‘en’)
[2012-02-03 15:15:32] VERBOSE[14262] pbx.c: – Executing [s@macro-outisbusy:5] Congestion(“Local/99933456840@from-internal-1b40;2”, “20”) in new stack
[2012-02-03 15:15:32] VERBOSE[14260] app_dial.c: – Local/99933456840@from-internal-1b40;1 is circuit-busy
[2012-02-03 15:15:32] VERBOSE[14262] app_macro.c: == Spawn extension (macro-outisbusy, s, 5) exited non-zero on ‘Local/99933456840@from-internal-1b40;2’ in macro ‘outisbusy’
[2012-02-03 15:15:32] VERBOSE[14262] pbx.c: == Spawn extension (from-internal, 99933456840, 6) exited non-zero on ‘Local/99933456840@from-internal-1b40;2’
[2012-02-03 15:15:32] VERBOSE[14260] app_dial.c: == Everyone is busy/congested at this time (1:0/1/0)
[2012-02-03 15:15:32] VERBOSE[14262] pbx.c: – Executing [h@from-internal:1] Hangup(“Local/99933456840@from-internal-1b40;2”, “”) in new stack
[2012-02-03 15:15:32] VERBOSE[14262] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘Local/99933456840@from-internal-1b40;2’
[2012-02-03 15:15:32] VERBOSE[14260] pbx.c: – Executing [s@macro-dial:8] Set(“Local/FMGL-99933456840#@from-internal-9a10;2”, “DIALSTATUS=CONGESTION”) in new stack
[2012-02-03 15:15:32] VERBOSE[14260] pbx.c: – Executing [s@macro-dial:9] GosubIf(“Local/FMGL-99933456840#@from-internal-9a10;2”, “0?CONGESTION,1”) in new stack
[2012-02-03 15:15:32] VERBOSE[14260] pbx.c: – Executing [FMGL-99933456840#@from-internal:8] Hangup(“Local/FMGL-99933456840#@from-internal-9a10;2”, “”) in new stack
[2012-02-03 15:15:32] VERBOSE[14260] pbx.c: == Spawn extension (from-internal, FMGL-99933456840#, 8) exited non-zero on ‘Local/FMGL-99933456840#@from-internal-9a10;2’
[2012-02-03 15:15:32] VERBOSE[14260] pbx.c: – Executing [h@from-internal:1] Hangup(“Local/FMGL-99933456840#@from-internal-9a10;2”, “”) in new stack
[2012-02-03 15:15:32] VERBOSE[14260] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘Local/FMGL-99933456840#@from-internal-9a10;2’
[2012-02-03 15:15:39] VERBOSE[14256] app_macro.c: == Spawn extension (macro-dial, s, 7) exited non-zero on ‘DAHDI/2-1’ in macro ‘dial’
[2012-02-03 15:15:39] VERBOSE[14256] pbx.c: == Spawn extension (from-did-direct, 8170, 17) exited non-zero on ‘DAHDI/2-1’
[2012-02-03 15:15:39] VERBOSE[14259] app_macro.c: == Spawn extension (macro-dial-one, s, 42) exited non-zero on ‘Local/FMPR-8170@from-internal-2b83;2’ in macro ‘dial-one’
[2012-02-03 15:15:39] VERBOSE[14259] app_macro.c: == Spawn extension (macro-simple-dial, s, 6) exited non-zero on ‘Local/FMPR-8170@from-internal-2b83;2’ in macro ‘simple-dial’
[2012-02-03 15:15:39] VERBOSE[14259] pbx.c: == Spawn extension (from-internal, FMPR-8170, 5) exited non-zero on ‘Local/FMPR-8170@from-internal-2b83;2’
[2012-02-03 15:15:39] VERBOSE[14256] pbx.c: – Executing [h@from-did-direct:1] Macro(“DAHDI/2-1”, “hangupcall,”) in new stack
[2012-02-03 15:15:39] VERBOSE[14259] pbx.c: – Executing [h@from-internal:1] Hangup(“Local/FMPR-8170@from-internal-2b83;2”, “”) in new stack
[2012-02-03 15:15:39] VERBOSE[14259] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘Local/FMPR-8170@from-internal-2b83;2’
[2012-02-03 15:15:39] VERBOSE[14256] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“DAHDI/2-1”, “1?theend”) in new stack
[2012-02-03 15:15:39] VERBOSE[14256] pbx.c: – Goto (macro-hangupcall,s,3)
[2012-02-03 15:15:39] VERBOSE[14256] pbx.c: – Executing [s@macro-hangupcall:3] Hangup(“DAHDI/2-1”, “”) in new stack
[2012-02-03 15:15:39] VERBOSE[14256] app_macro.c: == Spawn extension (macro-hangupcall, s, 3) exited non-zero on ‘DAHDI/2-1’ in macro ‘hangupcall’
[2012-02-03 15:15:39] VERBOSE[14256] pbx.c: == Spawn extension (from-did-direct, h, 1) exited non-zero on ‘DAHDI/2-1’
[2012-02-03 15:15:39] VERBOSE[14256] sig_analog.c: – Hanging up on ‘DAHDI/2-1’
[2012-02-03 15:15:39] VERBOSE[14256] chan_dahdi.c: – Hungup ‘DAHDI/2-1’
[2012-02-03 15:15:39] VERBOSE[14257] app_mixmonitor.c: == MixMonitor close filestream
[2012-02-03 15:15:39] VERBOSE[14257] app_mixmonitor.c: == End MixMonitor Recording DAHDI/2-1