PLAR dahdi channel configuration

trockid · March 29, 2017, 2:44am

I have a scenario with a T1 with PLAR (ARD) lines on it running to an Adit600 converting the lines to analog (FXS TDM cards), going into an AEX2400 card mapped to SIP phone extensions.

I’m trying to see if its possible to terminate the T1 directly on the Freepbx server (with a Digium TE420 T1/E1 card).

The T1 is not a PRI, it’s CAS signaling, with ESF/B8ZS framing/coding.

My dahdi config for the span is like this…

framing/coding: ESF/B8ZS
Signaling: E&M Wink
Switchtype: EuroISDN (this was the default when picking E&M wink)
Sync/clock: 1
group: 0
context: from-digital

I set “Allow PRI discrete channels” to “yes”.

I created a dahdi channel DID for each DS0 channel, with the DID being the extension I want to be able to use that channel.

I created a dahdi trunk for each DS0 channel.

Finally, I created an outbound route corresponding to each trunk.

I moved the T1 from the Adit600 to the TE420 and it came up with no alarms.

When the remote end picks up the line it should ring the extension, but it doesn’t. I see nothing in the asterisk console until the remote end sets the phone back onhook, and I get this…

– Starting simple switch on ‘DAHDI/3-1’
– Executing [s@from-digital:1] NoOp(“DAHDI/3-1”, “No DID or CID Match”) in new stack
– Executing [s@from-digital:2] Answer(“DAHDI/3-1”, “”) in new stack
[2017-03-28 16:11:39] WARNING[28934][C-00000001]: chan_sip.c:22185 func_header_read: This function can only be used on SIP channels.
– Executing [s@from-digital:3] Log(“DAHDI/3-1”, "WARNING,Friendly Scanner from ") in new stack
[2017-03-28 16:11:39] WARNING[28934][C-00000001]: Ext. s:3 @ from-digital: Friendly Scanner from
– Executing [s@from-digital:4] Wait(“DAHDI/3-1”, “2”) in new stack
== Spawn extension (from-digital, s, 4) exited non-zero on ‘DAHDI/3-1’
– Executing [h@from-digital:1] Macro(“DAHDI/3-1”, “hangupcall,”) in new stack
– Executing [s@macro-hangupcall:1] ExecIf(“DAHDI/3-1”, “0?Set(CDR(recordingfile)=.)”) in new stack
– Executing [s@macro-hangupcall:2] GotoIf(“DAHDI/3-1”, “1?theend”) in new stack
– Goto (macro-hangupcall,s,4)
– Executing [s@macro-hangupcall:4] ExecIf(“DAHDI/3-1”, “0?Set(CDR(recordingfile)=)”) in new stack
– Executing [s@macro-hangupcall:5] Hangup(“DAHDI/3-1”, “”) in new stack
== Spawn extension (macro-hangupcall, s, 5) exited non-zero on ‘DAHDI/3-1’ in macro ‘hangupcall’
== Spawn extension (from-digital, h, 1) exited non-zero on ‘DAHDI/3-1’
– Hanging up on ‘DAHDI/3-1’
– Hungup ‘DAHDI/3-1’

When I try to dial the pattern matching the outbound route all I hear is an automated message about call forwarding on busy being enabled. I see this in the asterisk console.

-- Executing [*903@from-internal:1] Answer("SIP/4008-00000000", "") in new stack
-- Executing [*903@from-internal:2] Wait("SIP/4008-00000000", "1") in new stack
-- Executing [*903@from-internal:3] Macro("SIP/4008-00000000", "user-callerid,") in new stack
-- Executing [s@macro-user-callerid:1] Set("SIP/4008-00000000", "TOUCH_MONITOR=1490735367.0") in new stack
-- Executing [s@macro-user-callerid:2] Set("SIP/4008-00000000", "AMPUSER=4008") in new stack
-- Executing [s@macro-user-callerid:3] GotoIf("SIP/4008-00000000", "0?report") in new stack
-- Executing [s@macro-user-callerid:4] ExecIf("SIP/4008-00000000", "1?Set(REALCALLERIDNUM=4008)") in new stack
-- Executing [s@macro-user-callerid:5] Set("SIP/4008-00000000", "AMPUSER=4008") in new stack
-- Executing [s@macro-user-callerid:6] GotoIf("SIP/4008-00000000", "0?limit") in new stack
-- Executing [s@macro-user-callerid:7] Set("SIP/4008-00000000", "AMPUSERCIDNAME=TEST4008") in new stack
-- Executing [s@macro-user-callerid:8] GotoIf("SIP/4008-00000000", "0?report") in new stack
-- Executing [s@macro-user-callerid:9] Set("SIP/4008-00000000", "AMPUSERCID=4008") in new stack
-- Executing [s@macro-user-callerid:10] Set("SIP/4008-00000000", "__DIAL_OPTIONS=Ttr") in new stack
-- Executing [s@macro-user-callerid:11] Set("SIP/4008-00000000", "CALLERID(all)="TEST4008" <4008>") in new stack
-- Executing [s@macro-user-callerid:12] GotoIf("SIP/4008-00000000", "0?limit") in new stack
-- Executing [s@macro-user-callerid:13] ExecIf("SIP/4008-00000000", "0?Set(GROUP(concurrency_limit)=4008)") in new stack
-- Executing [s@macro-user-callerid:14] ExecIf("SIP/4008-00000000", "0?Set(CHANNEL(language)=)") in new stack
-- Executing [s@macro-user-callerid:15] GotoIf("SIP/4008-00000000", "0?continue") in new stack
-- Executing [s@macro-user-callerid:16] ExecIf("SIP/4008-00000000", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
-- Executing [s@macro-user-callerid:17] Set("SIP/4008-00000000", "__TTL=64") in new stack
-- Executing [s@macro-user-callerid:18] GotoIf("SIP/4008-00000000", "1?continue") in new stack
-- Goto (macro-user-callerid,s,29)
-- Executing [s@macro-user-callerid:29] Set("SIP/4008-00000000", "CALLERID(number)=4008") in new stack
-- Executing [s@macro-user-callerid:30] Set("SIP/4008-00000000", "CALLERID(name)=TEST4008") in new stack
-- Executing [s@macro-user-callerid:31] GotoIf("SIP/4008-00000000", "0?cnum") in new stack
-- Executing [s@macro-user-callerid:32] Set("SIP/4008-00000000", "CDR(cnam)=TEST4008") in new stack
-- Executing [s@macro-user-callerid:33] Set("SIP/4008-00000000", "CDR(cnum)=4008") in new stack
-- Executing [s@macro-user-callerid:34] Set("SIP/4008-00000000", "CHANNEL(language)=en") in new stack
-- Executing [*903@from-internal:4] Set("SIP/4008-00000000", "fromext=4008") in new stack
-- Executing [*903@from-internal:5] Set("SIP/4008-00000000", "toext=3") in new stack
-- Executing [*903@from-internal:6] Set("SIP/4008-00000000", "DB(CFB/4008)=3") in new stack
-- Executing [*903@from-internal:7] Gosub("SIP/4008-00000000", "app-cf-busy-on,lang-playback,1(hook_3)") in new stack
-- Executing [lang-playback@app-cf-busy-on:1] GosubIf("SIP/4008-00000000", "1?app-cf-busy-on,en,hook_3():app-cf-busy-on,en,hook_3()") in new stack
-- Executing [en@app-cf-busy-on:13] Playback("SIP/4008-00000000", "call-fwd-on-busy&for&extension") in new stack
-- <SIP/4008-00000000> Playing 'call-fwd-on-busy.ulaw' (language 'en')

== Spawn extension (app-cf-busy-on, en, 13) exited non-zero on ‘SIP/4008-00000000’

Any suggestions?

Thanks!

dicko · March 29, 2017, 3:11am

switchtype only applies to PRI’s , you might well need immediate=yes and some variety of FXS signalling for a ringdown, you really shouldn’t be using the “dahdi helper” module for this , to start off with, send these calls not to from-digital but to a “diagnostic” context that mayby just calls dumpchan() on exten ‘s’ which is ‘anything’, then watch the logs for what happens . . .

From the documentation of dahdi

; Specify whether the channel should be answered immediately or if the simple
; switch should provide dialtone, read digits, etc.
; Note: If immediate=yes the dialplan execution will always start at extension
; ‘s’ priority 1 regardless of the dialed number!
;
;immediate=yes

trockid · March 30, 2017, 1:45am

I got a tiny bit closer… Setting immediate=yes did not have any effect. I’m a novice at Asterisk so I’m not entirely sure how to setup the diagnostic context you mentioned, but I’ll dig into it.

I assigned the dahdi channels unique 4 digit DIDs under “DAHDI Channel DIDs”, and added inbound routes for those numbers with the destination being the extension of my test phone.

Still I noticed that it was complaining about “No DID or CID Match”. Interestingly, when I change the inbound route to specify ANY DID and ANY CID, it routes it to the desired extension. When the remote end picks up the line it rings my phone, but as soon as I pick up it instantly ends the call.

So two issues on inbound now.

why isn’t it routing the inbound call when the DID is specified?
why is it hanging up?

I’m still stuck where I was on outbound calls, no ringing, just plays the call forward on busy message.

Here are some more config snippets that seem pertinent perhaps.

In my test setup *903 is the dialplan intended to connect down to T1 DS0 channel 3. DID 9003 is what I have assigned to dahdi channel 3, and extension 4008 is my test phone.

extensions_additional.conf

[outbound-allroutes]
include => outbound-allroutes-custom
include => outrt-3 ; IPC_PLAR_03
exten => foo,1,Noop(bar)

;–== end of [outbound-allroutes] ==–;

[outrt-3] ; IPC_PLAR_03
include => outrt-3-custom
exten => *903,1,Macro(user-callerid,LIMIT,EXTERNAL,)
exten => *903,n,Gosub(sub-record-check,s,1(out,${EXTEN},dontcare))
exten => *903,n,ExecIf($[ “${CALLEE_ACCOUNCODE}” != “” ] ?Set(CDR(accountcode)=${CALLEE_ACCOUNCODE}))
exten => *903,n,Set(MOHCLASS=${IF($[“${MOHCLASS}”=“”]?default:${MOHCLASS})})
exten => *903,n,Set(_NODEST=)
exten => *903,n,Macro(dialout-trunk,4,${EXTEN},off)
exten => *903,n,Macro(outisbusy,)

;–== end of [outrt-3] ==–;

chan_dahdi_groups.conf

; [span_1]
signalling=em_w
switchtype=euroisdn
pridialplan=national
prilocaldialplan=national
group=0
context=from-digital
channel=>1-23

dahdi/system.conf

span=1,1,0,ESF,B8ZS
e&m=1-24
echocanceller=oslec,1-24
loadzone=us
defaultzone=us

extensions.conf

[from-digital]
include => from-pstn

[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

chan_dahdi.conf

[channels]
language=en
busydetect=no
busycount=10
usecallerid=no
callwaiting=no
usecallingpres=no
threewaycalling=no
transfer=no
cancallforward=no
callreturn=no
echocancel=no
echocancelwhenbridged=no
echotraining=no
immediate=yes
faxdetect=no
rxgain=0.0
txgain=0.0

dicko · March 30, 2017, 1:57am

If your span is not ear and mouth (unlikey that it is with a plar) then use good old 24 channel robbed bit , you will likely see an fxo on each ds0, so use fxs signaliing. If it worked on your adit, then use exactly the same config on your dahdi span.

trockid · March 30, 2017, 2:06am

What does RBS with fxs equate to in this list?

dicko · March 30, 2017, 2:09am

It will probably be FXS, but whether it is ground-start or loop-start , likely loop-start, but you would need to check with your provider

(RBS is “robbed bit signalling” it is how T1 channels look like analog lines, dahdi understands that well) but I really suggest you don’t use the dahdi “helper module” it likely won’t “help” you here:-)

trockid · March 31, 2017, 1:17am

dicko, you certainly know your stuff! Inbound calling is working after doing the following.

set the T1 signalling to FXSLS
changed the context from from-digital to from-analog (this allowed asterisk to set the DID and allow the inbound call rules to match appropriately on DID)

One niggling thing remains on inbound calls though…when the remote end first picks up the line, my local phone starts ringing, I pick it up, but they hear nothing on the line, and I hear nothing either. They then hang up and pick it back up. I immediately hear a click, and then we’re connected, both hear each other. Thoughts?

Outbound calling on these lines is still stuck with the original problem though. I noticed this in the logs and it seemed to stick out to me. Why the “toext=3”? Is that how it should look when dialing out a dahdi channel? Is it maybe a problem with the dial pattern I picked of *903?

-- Executing [*903@from-internal:1] Answer("SIP/4008-0000001c", "") in new stack
-- Executing [*903@from-internal:2] Wait("SIP/4008-0000001c", "1") in new stack
-- Executing [*903@from-internal:3] Macro("SIP/4008-0000001c", "user-callerid,") in new stack
-- Executing [*903@from-internal:4] Set("SIP/4008-0000001c", "fromext=4008") in new stack
-- Executing [*903@from-internal:5] Set("SIP/4008-0000001c", "toext=3") in new stack
-- Executing [*903@from-internal:6] Set("SIP/4008-0000001c", "DB(CFB/4008)=3") in new stack
-- Executing [*903@from-internal:7] Gosub("SIP/4008-0000001c", "app-cf-busy-on,lang-playback,1(hook_3)") in new stack

dicko · March 31, 2017, 1:40am

I doubt that you have CallerID on a PLAR ( because it is a PLAR). if you say you want to use it, it will wait for the CID “spill” between the first and second ring, there will be nothing there To call out you should be using something like DAHDI/G0 for your channel so you don’t get “glare” where an incoming call collides with an outgoing call on the same DS0

trockid · March 31, 2017, 2:07am

Yeah, I was just thinking I need to create the dahdi extensions. I’ll try this when I can take the circuit down again.

Thanks for all your help.

dicko · March 31, 2017, 2:08am

A group should suffice.

dicko · April 1, 2017, 7:36pm

BUT , it occurs to me after rereading, you want bidirectional calling, for that you might need em or em_w even perhaps Feat D or whatever, you might or might not be getting CID , em is immediate, em_w requires a wink, but apparently you tried that but it didn’t work, the others are different but only you and your provider need to know how it will work over RBS on a T1 , as suggested before , download and post the relevant parts of your adit 600 config’s, you can use telnet or a serial connection to get that stuff.

EDIT

for those that use analog lines, these ADIT 600’s these are absolutely the cheapest way to add POTS signalling to a FreePBX, either FXO ( a little more expensive ) or FXS (cheap as shit), you will need a T1/E1 card both ends, then you can have up to 48 channels for 3 bucks each add more shit then 96 channels surely way cheaper than Sangoma, Digium, Cisco, Medaitrix, Quintum, or Audiocodes or the Chinese Shit , Thank you Dell, Adit and ebay, it never worked on Windoze so it is being ‘dumped’ by everyone who got conned but the hardware is rock solid

trockid · May 31, 2017, 12:17am

I’m reviving this thread because I’m still running into a significant problem. I am able to get into the adit600 via console and verified the configuration.

> show a:1:1-8
SLOT A:
Settings for DS1  1:   Channel  1:
    Type:            VOICE
    Signaling:       PLAR
    Interface Side:  DROP
SLOT A:
Settings for DS1  1:   Channel  2:
    Type:            VOICE
    Signaling:       PLAR
    Interface Side:  DROP
SLOT A:
Settings for DS1  1:   Channel  3:
    Type:            VOICE
    Signaling:       PLAR
    Interface Side:  DROP

> show connect a:1:1-8
    From            Desc                    Desc            To      Comment
 -----------  ------------------      -----------------  ---------- --------
 A:01:01       PLAR VOICE   DS0 <--> FXS    VOICE LS     1:01
 A:01:02       PLAR VOICE   DS0 <--> FXS    VOICE LS     1:02
 A:01:03       PLAR VOICE   DS0 <--> FXS    VOICE LS     1:03

I can receive calls when the other end picks up the line, and dial down via the DAHDI DID…sort of. The problem is thus…

When DAHDI/Asterisk first start up the remote end immediately starts ringing, without having initiated a call from freepbx.
If the remote end picks up the line they hear nothing.
if they then hang-up the remote end the local extension I have assigned via inbound route starts to ring.
If I pick it up, there is obviously nobody on the line, and I just have a silent open line
If I hang-up the line, the remote end starts ringing again!

I should note that at points 2 and 4 that if the opposing end also picks up the line we’re connected and hear each other. To keep the circuit from ringing back and forth when not in use one side must park it on hold.

Any thoughts?

dicko · May 31, 2017, 12:25am

Did you disable CallerID in Dahdi?

trockid · May 31, 2017, 12:43am

Yes, usecallerid=no

Also have immediate=yes for now, although I tried that both ways and it didn’t affect the result.

dicko · May 31, 2017, 1:10am

When you change that sort of stuff in dahdi, are you stopping asterisk , then dahdi then restarting them every time you edit the files? If you use have immediate=on (you probably should) did you send it to a context that processes the “s” extension and gives you feed back ?

trockid · May 31, 2017, 1:58am

I’m actually using the “DAHDi Config” from within freepbx (I know that’s blasphemous), and hitting Apply, followed by “Restart DAHDi & Asterisk”. They are both definitely restarting as I watch the asterisk console and check the logs while doing so. Context on the span is the standard “from-analog”.

current chan_dahdi.conf

[general]

; generated by module
#include chan_dahdi_general.conf

; for user additions not provided by module
#include chan_dahdi_general_custom.conf

[channels]
language=en
busydetect=yes
busycount=10
usecallerid=no
callwaiting=no
usecallingpres=no
threewaycalling=no
transfer=no
cancallforward=no
callreturn=yes
echocancel=yes
echocancelwhenbridged=no
echotraining=no
immediate=yes
faxdetect=no
rxgain=0.0
txgain=0.0
relaxdtmf=yes

; for user additions not provided by module
#include chan_dahdi_channels_custom.conf

; include dahdi groups defined by DAHDI module of FreePBX
#include chan_dahdi_groups.conf

; include dahdi extensions defined in FreePBX
#include chan_dahdi_additional.conf

current chan_dahdi_groups.conf

; [span_1]
signalling=fxs_ls
switchtype=euroisdn
pridialplan=national
prilocaldialplan=national
rxgain=1.0
group=0
context=from-analog
channel=>1-23

I’ll follow-up shortly with some actual log output.

edit: I guess I should say that I’m assuming that it’s restarting DAHDi, I can’t tell for sure from the logs, but asterisk definitely.

dicko · May 31, 2017, 2:15am

I believe I suggested that you “Don’t do that” but knock yourself out. . .

trockid · May 31, 2017, 2:21am

After Asterisk & presumably DAHDI restart the remote end of the circuit starts ringing and I see nothing at all occurring in the logs at that time. After the remote end picks up, then hangs up, I see this, just like a normal inbound call, and my phone rings.

[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] sig_analog.c:     -- Starting simple switch on 'DAHDI/7-1'
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@from-analog:1] NoOp("DAHDI/7-1", "Entering from-dahdi with DID == ") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@from-analog:2] Ringing("DAHDI/7-1", "") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@from-analog:3] Set("DAHDI/7-1", "DID=s") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@from-analog:4] NoOp("DAHDI/7-1", "DID is now s") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@from-analog:5] GotoIf("DAHDI/7-1", "1?dahdiok:checkzap") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (from-analog,s,9)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@from-analog:9] NoOp("DAHDI/7-1", "Is a DAHDi Channel") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@from-analog:10] Set("DAHDI/7-1", "CHAN=7-1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@from-analog:11] Set("DAHDI/7-1", "CHAN=7") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@from-analog:12] Macro("DAHDI/7-1", "from-dahdi-7,s,1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-from-dahdi-7:1] NoOp("DAHDI/7-1", "Entering macro-from-dahdi-7 with DID = s and setting to: 9107") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-from-dahdi-7:2] Set("DAHDI/7-1", "__FROM_DID=9107") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-from-dahdi-7:3] Goto("DAHDI/7-1", "from-trunk,9107,1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (from-trunk,9107,1)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] app_macro.c:   == Channel 'DAHDI/7-1' jumping out of macro 'from-dahdi-7'
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:1] Set("DAHDI/7-1", "__DIRECTION=INBOUND") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:2] Gosub("DAHDI/7-1", "sub-record-check,s,1(in,9107,dontcare)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:1] GotoIf("DAHDI/7-1", "0?initialized") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:2] Set("DAHDI/7-1", "__REC_STATUS=INITIALIZED") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:3] Set("DAHDI/7-1", "NOW=1496182553") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:4] Set("DAHDI/7-1", "__DAY=30") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:5] Set("DAHDI/7-1", "__MONTH=05") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:6] Set("DAHDI/7-1", "__YEAR=2017") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:7] Set("DAHDI/7-1", "__TIMESTR=20170530-171553") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:8] Set("DAHDI/7-1", "__FROMEXTEN=unknown") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:9] Set("DAHDI/7-1", "__MON_FMT=wav") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:10] NoOp("DAHDI/7-1", "Recordings initialized") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:11] ExecIf("DAHDI/7-1", "0?Set(ARG3=dontcare)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:12] Set("DAHDI/7-1", "REC_POLICY_MODE_SAVE=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:13] ExecIf("DAHDI/7-1", "0?Set(REC_STATUS=NO)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:14] GotoIf("DAHDI/7-1", "2?checkaction") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (sub-record-check,s,17)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:17] GotoIf("DAHDI/7-1", "1?sub-record-check,in,1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (sub-record-check,in,1)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [in@sub-record-check:1] NoOp("DAHDI/7-1", "Inbound Recording Check to 9107") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [in@sub-record-check:2] Set("DAHDI/7-1", "FROMEXTEN=unknown") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [in@sub-record-check:3] ExecIf("DAHDI/7-1", "0?Set(FROMEXTEN=)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [in@sub-record-check:4] Gosub("DAHDI/7-1", "recordcheck,1(dontcare,in,9107)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [recordcheck@sub-record-check:1] NoOp("DAHDI/7-1", "Starting recording check against dontcare") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [recordcheck@sub-record-check:2] Goto("DAHDI/7-1", "dontcare") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (sub-record-check,recordcheck,3)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [recordcheck@sub-record-check:3] Return("DAHDI/7-1", "") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [in@sub-record-check:5] Return("DAHDI/7-1", "") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:3] Gosub("DAHDI/7-1", "app-blacklist-check,s,1()") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@app-blacklist-check:1] GotoIf("DAHDI/7-1", "0?blacklisted") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@app-blacklist-check:2] Set("DAHDI/7-1", "CALLED_BLACKLIST=1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@app-blacklist-check:3] Return("DAHDI/7-1", "") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:4] Set("DAHDI/7-1", "__FROM_DID=9107") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:5] Set("DAHDI/7-1", "CDR(did)=9107") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:6] ExecIf("DAHDI/7-1", "1 ?Set(CALLERID(name)=)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:7] Set("DAHDI/7-1", "__MOHCLASS=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:8] Set("DAHDI/7-1", "__REVERSAL_REJECT=FALSE") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:9] GotoIf("DAHDI/7-1", "1?post-reverse-charge") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (from-trunk,9107,11)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:11] NoOp("DAHDI/7-1", "") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:12] Set("DAHDI/7-1", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:13] Set("DAHDI/7-1", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:14] Set("DAHDI/7-1", "CALLERID(name-pres)=allowed_not_screened") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:15] Set("DAHDI/7-1", "CALLERID(num-pres)=allowed_not_screened") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:16] NoOp("DAHDI/7-1", "CallerID Entry Point") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [9107@from-trunk:17] Goto("DAHDI/7-1", "from-did-direct,6666,1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (from-did-direct,6666,1)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [6666@from-did-direct:1] GotoIf("DAHDI/7-1", "1?ext-local,6666,1:followme-check,6666,1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (ext-local,6666,1)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [6666@ext-local:1] Set("DAHDI/7-1", "__RINGTIMER=15") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [6666@ext-local:2] Macro("DAHDI/7-1", "exten-vm,6666,6666,0,0,0") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-exten-vm:1] Macro("DAHDI/7-1", "user-callerid,") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:1] Set("DAHDI/7-1", "TOUCH_MONITOR=1496182553.0") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:2] Set("DAHDI/7-1", "AMPUSER=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:3] GotoIf("DAHDI/7-1", "0?report") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:4] ExecIf("DAHDI/7-1", "1?Set(REALCALLERIDNUM=)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:5] Set("DAHDI/7-1", "AMPUSER=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:6] GotoIf("DAHDI/7-1", "0?limit") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:7] Set("DAHDI/7-1", "AMPUSERCIDNAME=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:8] GotoIf("DAHDI/7-1", "1?report") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (macro-user-callerid,s,15)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:15] GotoIf("DAHDI/7-1", "0?continue") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:16] ExecIf("DAHDI/7-1", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:17] Set("DAHDI/7-1", "__TTL=64") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:18] GotoIf("DAHDI/7-1", "1?continue") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (macro-user-callerid,s,29)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:29] Set("DAHDI/7-1", "CALLERID(number)=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:30] Set("DAHDI/7-1", "CALLERID(name)=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:31] GotoIf("DAHDI/7-1", "1?cnum") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (macro-user-callerid,s,33)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:33] Set("DAHDI/7-1", "CDR(cnum)=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-user-callerid:34] Set("DAHDI/7-1", "CHANNEL(language)=en") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-exten-vm:2] Set("DAHDI/7-1", "RingGroupMethod=none") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-exten-vm:3] Set("DAHDI/7-1", "__EXTTOCALL=6666") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-exten-vm:4] Set("DAHDI/7-1", "__PICKUPMARK=6666") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-exten-vm:5] Set("DAHDI/7-1", "RT=15") in new stack
[2017-05-30 17:15:53] WARNING[43379][C-00000000] chan_sip.c: This function can only be used on SIP channels.
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-exten-vm:6] ExecIf("DAHDI/7-1", "0?Macro(vm,6666,DIRECTDIAL,)") in new stack
[2017-05-30 17:15:53] WARNING[43379][C-00000000] chan_sip.c: This function can only be used on SIP channels.
[2017-05-30 17:15:53] WARNING[43379][C-00000000] chan_sip.c: This function can only be used on SIP channels.
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-exten-vm:7] ExecIf("DAHDI/7-1", "0?MacroExit()") in new stack
[2017-05-30 17:15:53] WARNING[43379][C-00000000] chan_sip.c: This function can only be used on SIP channels.
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-exten-vm:8] Gosub("DAHDI/7-1", "sub-record-check,s,1(exten,6666,dontcare)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:1] GotoIf("DAHDI/7-1", "7?initialized") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (sub-record-check,s,10)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:10] NoOp("DAHDI/7-1", "Recordings initialized") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:11] ExecIf("DAHDI/7-1", "0?Set(ARG3=dontcare)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:12] Set("DAHDI/7-1", "REC_POLICY_MODE_SAVE=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:13] ExecIf("DAHDI/7-1", "0?Set(REC_STATUS=NO)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:14] GotoIf("DAHDI/7-1", "5?checkaction") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (sub-record-check,s,17)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@sub-record-check:17] GotoIf("DAHDI/7-1", "1?sub-record-check,exten,1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (sub-record-check,exten,1)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [exten@sub-record-check:1] NoOp("DAHDI/7-1", "Exten Recording Check between unknown and 6666") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [exten@sub-record-check:2] Set("DAHDI/7-1", "CALLTYPE=external") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [exten@sub-record-check:3] ExecIf("DAHDI/7-1", "0?Set(CALLTYPE=)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [exten@sub-record-check:4] Set("DAHDI/7-1", "CALLEE=dontcare") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [exten@sub-record-check:5] ExecIf("DAHDI/7-1", "0?Set(CALLEE=dontcare)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [exten@sub-record-check:6] GotoIf("DAHDI/7-1", "1?callee") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (sub-record-check,exten,11)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [exten@sub-record-check:11] Gosub("DAHDI/7-1", "recordcheck,1(dontcare,external,6666)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [recordcheck@sub-record-check:1] NoOp("DAHDI/7-1", "Starting recording check against dontcare") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [recordcheck@sub-record-check:2] Goto("DAHDI/7-1", "dontcare") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (sub-record-check,recordcheck,3)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [recordcheck@sub-record-check:3] Return("DAHDI/7-1", "") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [exten@sub-record-check:12] Return("DAHDI/7-1", "") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-exten-vm:9] GotoIf("DAHDI/7-1", "1?macrodial") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (macro-exten-vm,s,15)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-exten-vm:15] GosubIf("DAHDI/7-1", "0?clrheader,1()") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-exten-vm:16] Macro("DAHDI/7-1", "dial-one,15,Ttr,6666") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:1] Set("DAHDI/7-1", "DEXTEN=6666") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:2] ExecIf("DAHDI/7-1", "0?Set(EXTTOCALL=6666)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:3] Set("DAHDI/7-1", "DIALSTATUS_CW=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:4] GosubIf("DAHDI/7-1", "0?screen,1()") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:5] GosubIf("DAHDI/7-1", "0?cf,1()") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:6] GotoIf("DAHDI/7-1", "1?skip1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (macro-dial-one,s,9)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:9] GotoIf("DAHDI/7-1", "0?nodial") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:10] GotoIf("DAHDI/7-1", "0?continue") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:11] Set("DAHDI/7-1", "EXTHASCW=ENABLED") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:12] GotoIf("DAHDI/7-1", "0?next1:cwinusebusy") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (macro-dial-one,s,24)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:24] GotoIf("DAHDI/7-1", "0?next3:continue") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (macro-dial-one,s,26)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:26] GotoIf("DAHDI/7-1", "0?nodial") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:27] GosubIf("DAHDI/7-1", "1?dstring,1():dlocal,1()") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:1] Set("DAHDI/7-1", "DSTRING=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:2] Set("DAHDI/7-1", "DEVICES=6666") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:3] ExecIf("DAHDI/7-1", "0?Return()") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:4] ExecIf("DAHDI/7-1", "0?Set(DEVICES=316)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:5] Set("DAHDI/7-1", "LOOPCNT=1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:6] Set("DAHDI/7-1", "ITER=1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:7] Set("DAHDI/7-1", "THISDIAL=SIP/6666") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:8] GosubIf("DAHDI/7-1", "1?zap2dahdi,1()") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [zap2dahdi@macro-dial-one:1] ExecIf("DAHDI/7-1", "0?Return()") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [zap2dahdi@macro-dial-one:2] Set("DAHDI/7-1", "NEWDIAL=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [zap2dahdi@macro-dial-one:3] Set("DAHDI/7-1", "LOOPCNT2=1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [zap2dahdi@macro-dial-one:4] Set("DAHDI/7-1", "ITER2=1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [zap2dahdi@macro-dial-one:5] Set("DAHDI/7-1", "THISPART2=SIP/6666") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [zap2dahdi@macro-dial-one:6] ExecIf("DAHDI/7-1", "0?Set(THISPART2=DAHDI/6666)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [zap2dahdi@macro-dial-one:7] Set("DAHDI/7-1", "NEWDIAL=SIP/6666&") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [zap2dahdi@macro-dial-one:8] Set("DAHDI/7-1", "ITER2=2") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [zap2dahdi@macro-dial-one:9] GotoIf("DAHDI/7-1", "0?begin2") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [zap2dahdi@macro-dial-one:10] Set("DAHDI/7-1", "THISDIAL=SIP/6666") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [zap2dahdi@macro-dial-one:11] Return("DAHDI/7-1", "") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:9] GotoIf("DAHDI/7-1", "1?docheck") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (macro-dial-one,dstring,14)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:14] GotoIf("DAHDI/7-1", "0?skipset") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:15] Set("DAHDI/7-1", "DSTRING=SIP/6666&") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:16] Set("DAHDI/7-1", "ITER=2") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:17] GotoIf("DAHDI/7-1", "0?begin") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:18] ExecIf("DAHDI/7-1", "0?Return()") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:19] Set("DAHDI/7-1", "DSTRING=SIP/6666") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [dstring@macro-dial-one:20] Return("DAHDI/7-1", "") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:28] GotoIf("DAHDI/7-1", "0?nodial") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:29] GotoIf("DAHDI/7-1", "0?skiptrace") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:30] GosubIf("DAHDI/7-1", "0?ctset,1():ctclear,1()") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [ctclear@macro-dial-one:1] NoOp("DAHDI/7-1", "Deleting: CALLTRACE/6666 ") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [ctclear@macro-dial-one:2] Return("DAHDI/7-1", "") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:31] Set("DAHDI/7-1", "D_OPTIONS=Ttr") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:32] NoOp("DAHDI/7-1", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:33] ExecIf("DAHDI/7-1", "0?Set(ALERT_INFO=)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:34] ExecIf("DAHDI/7-1", "0?Set(ALERT_INFO=)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:35] ExecIf("DAHDI/7-1", "0?Set(ALERT_INFO=)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:36] ExecIf("DAHDI/7-1", "0?Set(ALERT_INFO=;volume=)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:37] ExecIf("DAHDI/7-1", "0?Set(ALERT_INFO=;volume=)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:38] GosubIf("DAHDI/7-1", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:39] ExecIf("DAHDI/7-1", "0?Set(CHANNEL(musicclass)=)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:40] GosubIf("DAHDI/7-1", "0?qwait,1()") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:41] Set("DAHDI/7-1", "__CWIGNORE=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:42] Set("DAHDI/7-1", "__KEEPCID=TRUE") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:43] GotoIf("DAHDI/7-1", "0?usegoto,1") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:44] GotoIf("DAHDI/7-1", "1?godial") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Goto (macro-dial-one,s,49)
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:49] Macro("DAHDI/7-1", "dialout-one-predial-hook,") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dialout-one-predial-hook:1] MacroExit("DAHDI/7-1", "") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:50] ExecIf("DAHDI/7-1", "1?Set(D_OPTIONS=trI)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@macro-dial-one:51] Dial("DAHDI/7-1", "SIP/6666,15,trIb(func-apply-sipheaders^s^1)") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] netsock2.c:   == Using SIP RTP TOS bits 184
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] netsock2.c:   == Using SIP RTP CoS mark 5
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] app_stack.c:     -- SIP/6666-00000000 Internal Gosub(func-apply-sipheaders,s,1) start
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@func-apply-sipheaders:1] NoOp("SIP/6666-00000000", "Applying SIP Headers to channel") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@func-apply-sipheaders:2] Set("SIP/6666-00000000", "SIPHEADERKEYS=") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@func-apply-sipheaders:3] While("SIP/6666-00000000", "0") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] app_while.c:     -- Jumping to priority 6
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] pbx.c:     -- Executing [s@func-apply-sipheaders:7] Return("SIP/6666-00000000", "") in new stack
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] app_stack.c:   == Spawn extension (from-internal, 6666, 1) exited non-zero on 'SIP/6666-00000000'
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] app_stack.c:     -- SIP/6666-00000000 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] app_dial.c:     -- Called SIP/6666
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] app_dial.c:     -- Connected line update to DAHDI/7-1 prevented.
[2017-05-30 17:15:53] VERBOSE[43379][C-00000000] app_dial.c:     -- SIP/6666-00000000 is ringing

dicko · May 31, 2017, 2:25am

You apparently won’t accept my help/suggestions. But FreePBX/Sangoma provide paid support, I suggest you go do that.