asterisk1*CLI>
-- Accepting call from '856xxxxxxx' to '888xxxxxxx' on channel 0/1, span 1
Feb 8 15:30:22 DEBUG[25363]: chan_zap.c:1554 zt_enable_ec: Enabled echo cancellation on channel 1
-- Executing Set("Zap/1-1", "DID=888xxxxxxx") in new stack
-- Executing Goto("Zap/1-1", "s|1") in new stack
-- Goto (from-zaptel,s,1)
-- Executing NoOp("Zap/1-1", "Entering from-zaptel with DID == 888xxxxxxx") in new stack
-- Executing Ringing("Zap/1-1", "") in new stack
Feb 8 15:30:22 DEBUG[26058]: chan_zap.c:4981 zt_indicate: Requested indication 3 on channel Zap/1-1
Feb 8 15:30:22 DEBUG[26058]: pbx.c:1609 pbx_substitute_variables_helper_full: Expression result is '0'
Feb 8 15:30:22 DEBUG[26058]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '8882022154'
-- Executing Set("Zap/1-1", "DID=888xxxxxxx") in new stack
-- Executing NoOp("Zap/1-1", "DID is now 888xxxxxxx") in new stack
Feb 8 15:30:22 DEBUG[26058]: pbx.c:1609 pbx_substitute_variables_helper_full: Expression result is '1'
-- Executing GotoIf("Zap/1-1", "1?zapok:notzap") in new stack
-- Goto (from-zaptel,s,8)
-- Executing NoOp("Zap/1-1", "Is a Zaptel Channel") in new stack
-- Executing Set("Zap/1-1", "CHAN=1-1") in new stack
Feb 8 15:30:22 DEBUG[26058]: pbx.c:1542 pbx_substitute_variables_helper_full: Function result is '1'
-- Executing Set("Zap/1-1", "CHAN=1") in new stack
-- Executing Macro("Zap/1-1", "from-zaptel-1|888xxxxxxx|1") in new stack
Feb 8 15:30:22 WARNING[26058]: app_macro.c:208 macro_exec: No such context 'macro-from-zaptel-1' for macro 'from-zaptel-1'
-- Executing NoOp("Zap/1-1", "Returned from Macro from-zaptel-1") in new stack
-- Executing Goto("Zap/1-1", "from-pstn|888xxxxxxx|1") in new stack
-- Goto (from-pstn,888xxxxxxx,1)
-- Executing Set("Zap/1-1", "__FROM_DID=888xxxxxxx") in new stack
-- Executing Dial("Zap/1-1", "Zap/8/215xxxxxxx") in new stack
-- Requested transfer capability: 0x00 - SPEECH
-- Called 8/2153708898
Feb 8 15:30:22 DEBUG[25356]: channel.c:776 channel_find_locked: Avoiding initial deadlock for 'Zap/8-1'
Feb 8 15:30:23 DEBUG[25363]: chan_zap.c:8877 pri_dchannel: Queuing frame from PRI_EVENT_PROCEEDING on channel 0/8 span 1
-- Zap/8-1 is proceeding passing it to Zap/1-1
Feb 8 15:30:23 DEBUG[26058]: chan_zap.c:4981 zt_indicate: Requested indication 15 on channel Zap/1-1
Feb 8 15:30:23 DEBUG[26058]: chan_zap.c:5028 zt_indicate: Received AST_CONTROL_PROCEEDING on Zap/1-1
Feb 8 15:30:24 DEBUG[25363]: chan_zap.c:8851 pri_dchannel: Queuing frame from PRI_EVENT_PROGRESS on channel 0/8 span 1
-- Zap/8-1 is making progress passing it to Zap/1-1
Feb 8 15:30:24 DEBUG[26058]: chan_zap.c:4981 zt_indicate: Requested indication 14 on channel Zap/1-1
Feb 8 15:30:24 DEBUG[26058]: chan_zap.c:5046 zt_indicate: Received AST_CONTROL_PROGRESS on Zap/1-1
Feb 8 15:30:25 DEBUG[25363]: chan_zap.c:8851 pri_dchannel: Queuing frame from PRI_EVENT_PROGRESS on channel 0/8 span 1
-- Zap/8-1 is making progress passing it to Zap/1-1
Feb 8 15:30:25 DEBUG[26058]: chan_zap.c:4981 zt_indicate: Requested indication 14 on channel Zap/1-1
Feb 8 15:30:25 DEBUG[26058]: chan_zap.c:5046 zt_indicate: Received AST_CONTROL_PROGRESS on Zap/1-1
Feb 8 15:30:29 DEBUG[25363]: chan_zap.c:1554 zt_enable_ec: Enabled echo cancellation on channel 8
-- Zap/8-1 answered Zap/1-1
Feb 8 15:30:29 DEBUG[25356]: channel.c:776 channel_find_locked: Avoiding initial deadlock for 'Zap/8-1'
-- Attempting native bridge of Zap/1-1 and Zap/8-1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:3268 zt_bridge: master: 1, slave: 8, nothingok: 0
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:3283 zt_bridge: Stopping tones on 1/0 talking to 8/0
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:3295 zt_bridge: Stopping tones on 8/0 talking to 1/0
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1586 zt_disable_ec: disabled echo cancellation on channel 1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1586 zt_disable_ec: disabled echo cancellation on channel 8
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:3105 zt_link: Making 8 slave to master 1 at 0
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1377 conf_add: Added 20 to conference 9/1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1377 conf_add: Added 13 to conference 9/8
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1523 update_conf: Updated conferencing on 1, with 0 conference users
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1523 update_conf: Updated conferencing on 8, with 0 conference users
-- Channel 0/1, span 1 got hangup, cause 96
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1554 zt_enable_ec: Enabled echo cancellation on channel 1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1554 zt_enable_ec: Enabled echo cancellation on channel 8
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:3049 zt_unlink: Unlinking slave 8 from 1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1409 conf_del: Removed 20 from conference 9/1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1409 conf_del: Removed 13 from conference 9/8
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1523 update_conf: Updated conferencing on 1, with 0 conference users
Feb 8 15:30:29 DEBUG[26058]: channel.c:3778 ast_channel_bridge: Returning from native bridge, channels: Zap/1-1, Zap/8-1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:3015 zt_setoption: Set option AUDIO MODE, value: ON(1) on Zap/8-1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:2496 zt_hangup: Hangup: channel: 8 index = 0, normal = 20, callwait = -1, thirdcall = -1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:2645 zt_hangup: Not yet hungup... Calling hangup once with icause, and clearing call
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1586 zt_disable_ec: disabled echo cancellation on channel 8
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:2936 zt_setoption: Set option TDD MODE, value: OFF(0) on Zap/8-1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1523 update_conf: Updated conferencing on 8, with 0 conference users
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:3011 zt_setoption: Set option AUDIO MODE, value: OFF(0) on Zap/8-1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1586 zt_disable_ec: disabled echo cancellation on channel 8
-- Hungup 'Zap/8-1'
Feb 8 15:30:29 DEBUG[26058]: app_dial.c:1661 dial_exec_full: Exiting with DIALSTATUS=ANSWER.
== Spawn extension (from-pstn, 8882022154, 2) exited non-zero on 'Zap/1-1'
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:3015 zt_setoption: Set option AUDIO MODE, value: ON(1) on Zap/1-1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:2496 zt_hangup: Hangup: channel: 1 index = 0, normal = 13, callwait = -1, thirdcall = -1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:2632 zt_hangup: Already hungup... Calling hangup once, and clearing call
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1586 zt_disable_ec: disabled echo cancellation on channel 1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:2936 zt_setoption: Set option TDD MODE, value: OFF(0) on Zap/1-1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1523 update_conf: Updated conferencing on 1, with 0 conference users
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:3011 zt_setoption: Set option AUDIO MODE, value: OFF(0) on Zap/1-1
Feb 8 15:30:29 DEBUG[26058]: chan_zap.c:1586 zt_disable_ec: disabled echo cancellation on channel 1
-- Hungup 'Zap/1-1'