- Joined
- Jul 24, 2010
- Messages
- 59
- Reaction score
- 0
Hi,
My system runs
Elastix 2.3.0-7 / Asterisk 1.8.16.0-0 / dahdi drivers 2.4.1.2-10
Openvox card A400P with only 2 FXO card instaled (2 Australian landlines)
What's been happening is that for just one particular extension the calls are being dropped after a certain amount of time, when this user makes outgoing calls using the PSTN lines.
I have not been able to find why these calls are being dropped, but I suspect it's caused by the busydetect and busycount parameters in the chan_dahdi.conf file which are configured as busydetect=yes & busycount=6
I've read in the past that even the voice tone of the caller might affect the busycount detection as the voice might match the busy tone frequency. Is there anyway to check that this is indeed the cause for the drop outs?
Any clue would be much appreciated
Thank you in advance.
Juan
------------------------------------------------------------------------------------------------------------------------------------------------------------------------
chan_dahdi.conf:
[trunkgroups]
[channels]
context=from-pstn
signalling=fxs_ks
rxwink=300 ; Atlas seems to use long (250ms) winks
usecallerid=yes
hidecallerid=no
callwaiting=yes
usecallingpres=yes
callwaitingcallerid=yes
threewaycalling=yes
transfer=yes
canpark=yes
cancallforward=yes
callreturn=yes
echocancel=yes
echocancelwhenbridged=no
faxdetect=no
echotraining=800
rxgain=0.0
txgain=0.0
callgroup=1
pickupgroup=1
;Uncomment these lines if you have problems with the disconection of your analog lines
busydetect=yes
busycount=6
immediate=yes
#include dahdi-channels.conf
#include chan_dahdi_additional.conf
------------------------------------------------------------------------------------------------------------------------------------------------------------------------
These are the CLI results for the call:
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [0362214200@from-internal:1] Macro("SIP/211-00000031", "user-callerid,SKIPTTL,") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/211-00000031", "AMPUSER=211") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/211-00000031", "0?report") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/211-00000031", "1?Set(REALCALLERIDNUM=211)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:4] Set("SIP/211-00000031", "AMPUSER=211") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/211-00000031", "AMPUSERCIDNAME=Bruce") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/211-00000031", "0?report") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:7] Set("SIP/211-00000031", "AMPUSERCID=211") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:8] Set("SIP/211-00000031", "CALLERID(all)="Bruce" <211>") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:9] ExecIf("SIP/211-00000031", "0?Set(CHANNEL(language)=)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:10] GotoIf("SIP/211-00000031", "1?continue") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Goto (macro-user-callerid,s,19)
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:19] Set("SIP/211-00000031", "CALLERID(number)=211") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:20] Set("SIP/211-00000031", "CALLERID(name)=Bruce") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:21] NoOp("SIP/211-00000031", "Using CallerID "Bruce" <211>") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [0362214200@from-internal:2] NoOp("SIP/211-00000031", "Calling Out Route: AustLandline") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [0362214200@from-internal:3] Set("SIP/211-00000031", "MOHCLASS=default") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [0362214200@from-internal:4] Set("SIP/211-00000031", "_NODEST=") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [0362214200@from-internal:5] Macro("SIP/211-00000031", "record-enable,211,OUT,") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:1] GotoIf("SIP/211-00000031", "1?check") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Goto (macro-record-enable,s,4)
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:4] ExecIf("SIP/211-00000031", "0?MacroExit()") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:5] GotoIf("SIP/211-00000031", "0?Group:OUT") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Goto (macro-record-enable,s,15)
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:15] GotoIf("SIP/211-00000031", "0?IN") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:16] ExecIf("SIP/211-00000031", "0?MacroExit()") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:17] NoOp("SIP/211-00000031", "Recording enable for 211") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:18] Set("SIP/211-00000031", "CALLFILENAME=OUT211-20130306-114714-1362534434.102") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:19] Goto("SIP/211-00000031", "record") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Goto (macro-record-enable,s,23)
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:23] MixMonitor("SIP/211-00000031", "OUT211-20130306-114714-1362534434.102.wav,,") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:24] Set("SIP/211-00000031", "CDR(userfield)=audio:OUT211-20130306-114714-1362534434.102.wav") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:25] MacroExit("SIP/211-00000031", "") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [0362214200@from-internal:6] Macro("SIP/211-00000031", "dialout-trunk,1,0362214200,") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("SIP/211-00000031", "DIAL_TRUNK=1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/211-00000031", "0?sub-pincheck,s,1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/211-00000031", "0?disabletrunk,1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("SIP/211-00000031", "DIAL_NUMBER=0362214200") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("SIP/211-00000031", "DIAL_TRUNK_OPTIONS=Ttwr") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("SIP/211-00000031", "OUTBOUND_GROUP=OUT_1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/211-00000031", "0?nomax") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:8] GotoIf("SIP/211-00000031", "0?chanfull") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/211-00000031", "0?skipoutcid") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("SIP/211-00000031", "DIAL_TRUNK_OPTIONS=TW") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("SIP/211-00000031", "outbound-callerid,1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("SIP/211-00000031", "0?Set(CALLERPRES()=)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("SIP/211-00000031", "0?Set(REALCALLERIDNUM=211)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("SIP/211-00000031", "1?normcid") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Goto (macro-outbound-callerid,s,6)
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("SIP/211-00000031", "USEROUTCID=") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("SIP/211-00000031", "EMERGENCYCID=") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("SIP/211-00000031", "TRUNKOUTCID=") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("SIP/211-00000031", "1?trunkcid") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Goto (macro-outbound-callerid,s,12)
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("SIP/211-00000031", "0?Set(CALLERID(all)=)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("SIP/211-00000031", "0?Set(CALLERID(all)=)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/211-00000031", "0?Set(CALLERID(all)=)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("SIP/211-00000031", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("SIP/211-00000031", "0?sub-flp-1,s,1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("SIP/211-00000031", "OUTNUM=0362214200") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("SIP/211-00000031", "custom=DAHDI/1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/211-00000031", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)TW)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:16] Macro("SIP/211-00000031", "dialout-trunk-predial-hook,") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/211-00000031", "") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:17] GotoIf("SIP/211-00000031", "0?bypass,1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/211-00000031", "0?customtrunk") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:19] Dial("SIP/211-00000031", "DAHDI/1/0362214200,300,TW") in new stack
[Mar 6 11:47:14] VERBOSE[8410] app_dial.c: -- Called DAHDI/1/0362214200
[Mar 6 11:47:19] VERBOSE[8410] app_dial.c: -- DAHDI/1-1 answered SIP/211-00000031
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [h@macro-dialout-trunk:1] Macro("SIP/211-00000031", "hangupcall,") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/211-00000031", "0?endmixmoncheck") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:2] Set("SIP/211-00000031", "MIXMON_CALLFILENAME=/var/spool/asterisk/monitor/OUT211-20130306-114714-1362534434.102.wav") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:3] GotoIf("SIP/211-00000031", "1?defaultmixmondir") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,5)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:5] System("SIP/211-00000031", "test -e /var/spool/asterisk/monitor/OUT211-20130306-114714-1362534434.102.wav") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:6] NoOp("SIP/211-00000031", "SYSTEMSTATUS = SUCCESS") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:7] GotoIf("SIP/211-00000031", "1?endmixmoncheck") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,9)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:9] NoOp("SIP/211-00000031", "End of MIXMON check") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:10] GotoIf("SIP/211-00000031", "1?nomeetmemon") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,28)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:28] NoOp("SIP/211-00000031", "End of MEETME check") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:29] GotoIf("SIP/211-00000031", "1?noautomon") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,34)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:34] NoOp("SIP/211-00000031", "TOUCH_MONITOR_OUTPUT=") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:35] GotoIf("SIP/211-00000031", "1?noautomon2") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,41)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:41] NoOp("SIP/211-00000031", "MONITOR_FILENAME=") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:42] GotoIf("SIP/211-00000031", "1?skiprg") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,45)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:45] GotoIf("SIP/211-00000031", "1?skipblkvm") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,48)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:48] GotoIf("SIP/211-00000031", "1?theend") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,50)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:50] AGI("SIP/211-00000031", "hangup.agi") in new stack
[Mar 6 11:48:20] VERBOSE[8410] res_agi.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/hangup.agi
[Mar 6 11:48:20] VERBOSE[8410] res_agi.c: -- <SIP/211-00000031>AGI Script hangup.agi completed, returning 0
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:51] Hangup("SIP/211-00000031", "") in new stack
[Mar 6 11:48:20] VERBOSE[8410] app_macro.c: == Spawn extension (macro-hangupcall, s, 51) exited non-zero on 'SIP/211-00000031' in macro 'hangupcall'
[Mar 6 11:48:20] VERBOSE[8410] features.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'SIP/211-00000031'
[Mar 6 11:48:20] VERBOSE[8410] sig_analog.c: -- Hanging up on 'DAHDI/1-1'
[Mar 6 11:48:20] VERBOSE[8410] chan_dahdi.c: -- Hungup 'DAHDI/1-1'
[Mar 6 11:48:20] VERBOSE[8410] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 19) exited non-zero on 'SIP/211-00000031' in macro 'dialout-trunk'
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: == Spawn extension (from-internal, 0362214200, 6) exited non-zero on 'SIP/211-00000031'
My system runs
Elastix 2.3.0-7 / Asterisk 1.8.16.0-0 / dahdi drivers 2.4.1.2-10
Openvox card A400P with only 2 FXO card instaled (2 Australian landlines)
What's been happening is that for just one particular extension the calls are being dropped after a certain amount of time, when this user makes outgoing calls using the PSTN lines.
I have not been able to find why these calls are being dropped, but I suspect it's caused by the busydetect and busycount parameters in the chan_dahdi.conf file which are configured as busydetect=yes & busycount=6
I've read in the past that even the voice tone of the caller might affect the busycount detection as the voice might match the busy tone frequency. Is there anyway to check that this is indeed the cause for the drop outs?
Any clue would be much appreciated
Thank you in advance.
Juan
------------------------------------------------------------------------------------------------------------------------------------------------------------------------
chan_dahdi.conf:
[trunkgroups]
[channels]
context=from-pstn
signalling=fxs_ks
rxwink=300 ; Atlas seems to use long (250ms) winks
usecallerid=yes
hidecallerid=no
callwaiting=yes
usecallingpres=yes
callwaitingcallerid=yes
threewaycalling=yes
transfer=yes
canpark=yes
cancallforward=yes
callreturn=yes
echocancel=yes
echocancelwhenbridged=no
faxdetect=no
echotraining=800
rxgain=0.0
txgain=0.0
callgroup=1
pickupgroup=1
;Uncomment these lines if you have problems with the disconection of your analog lines
busydetect=yes
busycount=6
immediate=yes
#include dahdi-channels.conf
#include chan_dahdi_additional.conf
------------------------------------------------------------------------------------------------------------------------------------------------------------------------
These are the CLI results for the call:
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [0362214200@from-internal:1] Macro("SIP/211-00000031", "user-callerid,SKIPTTL,") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/211-00000031", "AMPUSER=211") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/211-00000031", "0?report") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/211-00000031", "1?Set(REALCALLERIDNUM=211)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:4] Set("SIP/211-00000031", "AMPUSER=211") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/211-00000031", "AMPUSERCIDNAME=Bruce") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/211-00000031", "0?report") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:7] Set("SIP/211-00000031", "AMPUSERCID=211") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:8] Set("SIP/211-00000031", "CALLERID(all)="Bruce" <211>") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:9] ExecIf("SIP/211-00000031", "0?Set(CHANNEL(language)=)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:10] GotoIf("SIP/211-00000031", "1?continue") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Goto (macro-user-callerid,s,19)
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:19] Set("SIP/211-00000031", "CALLERID(number)=211") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:20] Set("SIP/211-00000031", "CALLERID(name)=Bruce") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-user-callerid:21] NoOp("SIP/211-00000031", "Using CallerID "Bruce" <211>") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [0362214200@from-internal:2] NoOp("SIP/211-00000031", "Calling Out Route: AustLandline") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [0362214200@from-internal:3] Set("SIP/211-00000031", "MOHCLASS=default") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [0362214200@from-internal:4] Set("SIP/211-00000031", "_NODEST=") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [0362214200@from-internal:5] Macro("SIP/211-00000031", "record-enable,211,OUT,") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:1] GotoIf("SIP/211-00000031", "1?check") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Goto (macro-record-enable,s,4)
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:4] ExecIf("SIP/211-00000031", "0?MacroExit()") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:5] GotoIf("SIP/211-00000031", "0?Group:OUT") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Goto (macro-record-enable,s,15)
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:15] GotoIf("SIP/211-00000031", "0?IN") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:16] ExecIf("SIP/211-00000031", "0?MacroExit()") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:17] NoOp("SIP/211-00000031", "Recording enable for 211") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:18] Set("SIP/211-00000031", "CALLFILENAME=OUT211-20130306-114714-1362534434.102") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:19] Goto("SIP/211-00000031", "record") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Goto (macro-record-enable,s,23)
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:23] MixMonitor("SIP/211-00000031", "OUT211-20130306-114714-1362534434.102.wav,,") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:24] Set("SIP/211-00000031", "CDR(userfield)=audio:OUT211-20130306-114714-1362534434.102.wav") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-record-enable:25] MacroExit("SIP/211-00000031", "") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [0362214200@from-internal:6] Macro("SIP/211-00000031", "dialout-trunk,1,0362214200,") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("SIP/211-00000031", "DIAL_TRUNK=1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/211-00000031", "0?sub-pincheck,s,1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/211-00000031", "0?disabletrunk,1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("SIP/211-00000031", "DIAL_NUMBER=0362214200") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("SIP/211-00000031", "DIAL_TRUNK_OPTIONS=Ttwr") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("SIP/211-00000031", "OUTBOUND_GROUP=OUT_1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/211-00000031", "0?nomax") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:8] GotoIf("SIP/211-00000031", "0?chanfull") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/211-00000031", "0?skipoutcid") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("SIP/211-00000031", "DIAL_TRUNK_OPTIONS=TW") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("SIP/211-00000031", "outbound-callerid,1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("SIP/211-00000031", "0?Set(CALLERPRES()=)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("SIP/211-00000031", "0?Set(REALCALLERIDNUM=211)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("SIP/211-00000031", "1?normcid") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Goto (macro-outbound-callerid,s,6)
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("SIP/211-00000031", "USEROUTCID=") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("SIP/211-00000031", "EMERGENCYCID=") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("SIP/211-00000031", "TRUNKOUTCID=") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("SIP/211-00000031", "1?trunkcid") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Goto (macro-outbound-callerid,s,12)
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("SIP/211-00000031", "0?Set(CALLERID(all)=)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("SIP/211-00000031", "0?Set(CALLERID(all)=)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/211-00000031", "0?Set(CALLERID(all)=)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("SIP/211-00000031", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("SIP/211-00000031", "0?sub-flp-1,s,1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("SIP/211-00000031", "OUTNUM=0362214200") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("SIP/211-00000031", "custom=DAHDI/1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/211-00000031", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)TW)") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:16] Macro("SIP/211-00000031", "dialout-trunk-predial-hook,") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/211-00000031", "") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:17] GotoIf("SIP/211-00000031", "0?bypass,1") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/211-00000031", "0?customtrunk") in new stack
[Mar 6 11:47:14] VERBOSE[8410] pbx.c: -- Executing [s@macro-dialout-trunk:19] Dial("SIP/211-00000031", "DAHDI/1/0362214200,300,TW") in new stack
[Mar 6 11:47:14] VERBOSE[8410] app_dial.c: -- Called DAHDI/1/0362214200
[Mar 6 11:47:19] VERBOSE[8410] app_dial.c: -- DAHDI/1-1 answered SIP/211-00000031
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [h@macro-dialout-trunk:1] Macro("SIP/211-00000031", "hangupcall,") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/211-00000031", "0?endmixmoncheck") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:2] Set("SIP/211-00000031", "MIXMON_CALLFILENAME=/var/spool/asterisk/monitor/OUT211-20130306-114714-1362534434.102.wav") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:3] GotoIf("SIP/211-00000031", "1?defaultmixmondir") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,5)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:5] System("SIP/211-00000031", "test -e /var/spool/asterisk/monitor/OUT211-20130306-114714-1362534434.102.wav") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:6] NoOp("SIP/211-00000031", "SYSTEMSTATUS = SUCCESS") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:7] GotoIf("SIP/211-00000031", "1?endmixmoncheck") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,9)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:9] NoOp("SIP/211-00000031", "End of MIXMON check") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:10] GotoIf("SIP/211-00000031", "1?nomeetmemon") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,28)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:28] NoOp("SIP/211-00000031", "End of MEETME check") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:29] GotoIf("SIP/211-00000031", "1?noautomon") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,34)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:34] NoOp("SIP/211-00000031", "TOUCH_MONITOR_OUTPUT=") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:35] GotoIf("SIP/211-00000031", "1?noautomon2") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,41)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:41] NoOp("SIP/211-00000031", "MONITOR_FILENAME=") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:42] GotoIf("SIP/211-00000031", "1?skiprg") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,45)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:45] GotoIf("SIP/211-00000031", "1?skipblkvm") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,48)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:48] GotoIf("SIP/211-00000031", "1?theend") in new stack
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Goto (macro-hangupcall,s,50)
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:50] AGI("SIP/211-00000031", "hangup.agi") in new stack
[Mar 6 11:48:20] VERBOSE[8410] res_agi.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/hangup.agi
[Mar 6 11:48:20] VERBOSE[8410] res_agi.c: -- <SIP/211-00000031>AGI Script hangup.agi completed, returning 0
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: -- Executing [s@macro-hangupcall:51] Hangup("SIP/211-00000031", "") in new stack
[Mar 6 11:48:20] VERBOSE[8410] app_macro.c: == Spawn extension (macro-hangupcall, s, 51) exited non-zero on 'SIP/211-00000031' in macro 'hangupcall'
[Mar 6 11:48:20] VERBOSE[8410] features.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'SIP/211-00000031'
[Mar 6 11:48:20] VERBOSE[8410] sig_analog.c: -- Hanging up on 'DAHDI/1-1'
[Mar 6 11:48:20] VERBOSE[8410] chan_dahdi.c: -- Hungup 'DAHDI/1-1'
[Mar 6 11:48:20] VERBOSE[8410] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 19) exited non-zero on 'SIP/211-00000031' in macro 'dialout-trunk'
[Mar 6 11:48:20] VERBOSE[8410] pbx.c: == Spawn extension (from-internal, 0362214200, 6) exited non-zero on 'SIP/211-00000031'