Odd SIP asterisk issues

I have 2 SIP lines from the same provider called sip1 and sip2. In my out going trunk i have sip1 that fails over to sip 2 if all outgoing lines on sip 1 are full, but sip line 2 will not work. When i use sip2 creds in a phone “linksys” it works fine and the “sip show” commands say everything is fine. If i remove sip1 from the out going trunk and i try to call out using sip2 i get a busy sound and my logs say this:

Jun 17 13:53:09 VERBOSE[4323] logger.c: – SIP/SIPLine2-08181148 is circuit-busy
Jun 17 13:53:09 DEBUG[4323] chan_sip.c: update_call_counter(3391732) - decrement call limit counter
Jun 17 13:53:09 VERBOSE[4323] logger.c: == Everyone is busy/congested at this time (1:0/1/0)
Jun 17 13:53:09 DEBUG[4323] app_dial.c: Exiting with DIALSTATUS=CONGESTION.
Jun 17 13:53:09 DEBUG[4323] app_macro.c: Executed application: Dial
Jun 17 13:53:09 VERBOSE[4323] logger.c: – Executing Goto(“SIP/107-081df6c8”, “s-CONGESTION|1”) in new stack
Jun 17 13:53:09 VERBOSE[4323] logger.c: – Goto (macro-dialout-trunk,s-CONGESTION,1)
Jun 17 13:53:09 DEBUG[4323] app_macro.c: Executed application: Goto
Jun 17 13:53:09 DEBUG[4323] pbx.c: Expression result is '1’
Jun 17 13:53:09 VERBOSE[4323] logger.c: – Executing GotoIf(“SIP/107-081df6c8”, “1?noreport”) in new stack
Jun 17 13:53:09 VERBOSE[4323] logger.c: – Goto (macro-dialout-trunk,s-CONGESTION,3)
Jun 17 13:53:09 DEBUG[4323] app_macro.c: Executed application: GotoIf
Jun 17 13:53:09 VERBOSE[4323] logger.c: – Executing NoOp(“SIP/107-081df6c8”, “TRUNK Dial failed due to CONGESTION - failing through to other trunks”) in new stack"

sip_additional.conf

[SIP1]
username=*****
type=peer
secret=*****
qualify=yes
nat=yes
insecure=very
host=*********
fromuser=********
dtmfmode=auto
disallow=all
context=from-trunk
canrenvite=no
callerid=GrandCare Systems
allow=alaw
allow=ulaw

[SIP2]
username=******
type=peer
secret=*****
qualify=yes
nat=yes
insecure=very
host=*******
fromuser=*******
dtmfmode=auto
disallow=all
context=from-trunk
canrenvite=no
callerid=GrandCare Systems
allow=alaw
allow=ulaw

anyone have an idea of what might be happening here?

Can it be that your ITSP is rejecting the call ?

why would sip2 work on the linksys phone with out any issues in the same network. i only get the busy sounds and errors when asterisk is handling everything. and its my ISP that provides the SIP lines. i been searching google and banging my head against the wall for two days now. I just have no idea where to go from here. . .

why don’t you check your sip debug?

Hi

OK so no dialplan, no mention of the ITSP and no sip debug

Only clue is it works on a phone but not asterisk, So you have got something wrong with the config . But with so little to go on who knows what it is.

Ian

Ok my dial plan is below and my ITSP is Red Gap “redgap.com”.

===Dial plan===
; include extension contexts generated from AMP
#include extensions_additional.conf

; Customizations to this dialplan should be made in extensions_custom.conf
; See extensions_custom.conf.sample for an example
#include extensions_custom.conf

[from-trunk] ; just an alias since VoIP shouldn’t be called PSTN
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-catchall ; THIS MUST COME AFTER ext-did
include => from-did-direct ; MODIFICATOIN (PL) for findmefollow if enabled, should be bofore ext-local
exten => fax,1,Goto(ext-fax,in_fax,1)

; MODIFICATION (PL)
;
; Required to assure that direct dids go to personal ring group before local extension.
; This could be auto-generated however I it is prefered to be put here and hard coded
; so that it can be modified if ext-local should take precedence in certain situations.
; will have to decide what to do later.
;
[from-did-direct]
include => ext-findmefollow
include => ext-local

[default]

exten => 106,1,SetVar(DYNAMIC_FEATURES=automon)
exten => 106,2,Dial(SIP/106,wW)

[IncomingCall]
exten => s,1,Set(CALLFILENAME=${EXTEN:1}${CALLERIDNUM})
exten => s,2,Monitor(wav,${CALLFILENAME},m)

; ############################################################################
; Macros [macro]
; ############################################################################

; Rings one or more extensions. Handles things like call forwarding and DND
; We don’t call dial directly for anything internal anymore.
; ARGS: $TIMER, $OPTIONS, $EXT1, $EXT2, $EXT3, …
; Use a Macro call such as the following:
; Macro(dial,$DIAL_TIMER,$DIAL_OPTIONS,$EXT1,$EXT2,$EXT3,…)
[macro-dial]
exten => s,1,GotoIf($["${MOHCLASS}" = “”]?dial)
exten => s,2,SetMusicOnHold(${MOHCLASS})
exten => s,3(dial),AGI(dialparties.agi)
exten => s,4,NoOp(Returned from dialparties with no extensions to call and DIALSTATUS: ${DIALSTATUS})

exten => s,10,Dial(${ds}) ; dialparties will set the priority to 10 if $ds is not null
exten => s,11,Set(DIALSTATUS=${IF($["${DIALSTATUS_CW}"!="" ]?${DIALSTATUS_CW}:${DIALSTATUS})})

exten => s,20,NoOp(Returned from dialparties with hunt groups to dial )
exten => s,21,Set(HuntLoop=0)
exten => s,22,GotoIf($[${HuntMembers} >= 1]?30 ) ; if this is from rg-group, don’t strip prefix
exten => s,23,NoOp(Returning there are no members left in the hunt group to ring)

exten => s,30,Set(HuntMember=HuntMember${HuntLoop})
exten => s,31,GotoIf($[$["${CALLTRACE_HUNT}" != “” ] & $["${RingGroupMethod}" = “hunt” ]]?32:35 ) ; Set CAll Trace for Hunt member we are going to call
exten => s,32,Set(CT_EXTEN=${CUT(ARG3,$[${HuntLoop} + 1])})
exten => s,33,Set(DB(CALLTRACE/${CT_EXTEN})=${CALLTRACE_HUNT})
exten => s,34,Goto(s,42)

exten => s,35,GotoIf($[$["${CALLTRACE_HUNT}" != “” ] & $["${RingGroupMethod}" = “memoryhunt” ]]?36:50 ) ;Set Call Trace for each hunt member we are going to call "Memory groups have multiple members to set CALL TRACE For hence the loop
exten => s,36,Set(CTLoop=0)
exten => s,37,GotoIf($[${CTLoop} > ${HuntLoop}]?42 ) ; if this is from rg-group, don’t strip prefix
exten => s,38,Set(CT_EXTEN=${CUT(ARG3,$[${CTLoop} + 1])})
exten => s,39,Set(DB(CALLTRACE/${CT_EXTEN})=${CALLTRACE_HUNT})
exten => s,40,Set(CTLoop=$[1 + ${CTLoop}])
exten => s,41,Goto(s,37)

exten => s,42,Dial(${${HuntMember}}${ds} ) ; dialparties will set the priority to 20 if $ds is not null and its a hunt group
exten => s,43,Set(HuntLoop=$[1 + ${HuntLoop}])
exten => s,44,GotoIf($[$[$[“foo${RingGroupMethod}” != “foofirstavailable”] & $[“foo${RingGroupMethod}” != “foofirstnotonphone”]] | $[“foo${DialStatus}” = “fooBUSY”]]?46)
exten => s,45,Set(HuntMembers=0)
exten => s,46,Set(HuntMembers=$[${HuntMembers} - 1])
exten => s,47,Goto(s,22)
exten => s,50,DBdel(CALLTRACE/${CT_EXTEN})
exten => s,51,Goto(s,42)

; make sure hungup calls go here so that proper cleanup occurs from call confirmed calls and the like
;
exten => h,1,Macro(hangupcall)

; Ring an extension, if the extension is busy or there is no answer send it
; to voicemail
; ARGS: $VMBOX, $EXT
[macro-exten-vm]
exten => s,1,Macro(user-callerid)

exten => s,n,Set(FROMCONTEXT=exten-vm)
exten => s,n,Set(VMBOX=${ARG1})
exten => s,n,Set(EXTTOCALL=${ARG2})
exten => s,n,Set(CFUEXT=${DB(CFU/${EXTTOCALL})})
exten => s,n,Set(CFBEXT=${DB(CFB/${EXTTOCALL})})
exten => s,n,Set(RT=${IF($[$["${VMBOX}"!=“novm”] | $[“foo${CFUEXT}”!=“foo”]]?${RINGTIMER}:"")})
exten => s,n,Macro(record-enable,${EXTTOCALL},IN)

exten => s,n,Macro(dial,${RT},${DIAL_OPTIONS},${EXTTOCALL})
exten => s,n,Set(SV_DIALSTATUS=${DIALSTATUS})
exten => s,n,GosubIf($[$["${SV_DIALSTATUS}"=“NOANSWER”] & $[“foo${CFUEXT}”!=“foo”]]?docfu,1) ; check for CFU in use on no answer
exten => s,n,GosubIf($[$["${SV_DIALSTATUS}"=“BUSY”] & $[“foo${CFBEXT}”!=“foo”]]?docfb,1) ; check for CFB in use on busy
exten => s,n,Set(DIALSTATUS=${SV_DIALSTATUS})
exten => s,n,NoOp(Voicemail is ‘${VMBOX}’)
exten => s,n,GotoIf($["${VMBOX}" = “novm”]?s-${DIALSTATUS},1) ; no voicemail in use for this extension
exten => s,n,NoOp(Sending to Voicemail box ${EXTTOCALL})
exten => s,n,Macro(vm,${VMBOX},${DIALSTATUS})

; Try the Call Forward on No Answer / Unavailable number
exten => docfu,1,Set(RTCFU=${IF($["${VMBOX}"!=“novm”]?${RINGTIMER}:"")})
exten => docfu,n,Dial(Local/${CFUEXT}@from-internal/n,${RTCFU},${DIAL_OPTIONS})
exten => docfu,n,Return

; Try the Call Forward on Busy number
exten => docfb,1,Set(RTCFB=${IF($["${VMBOX}"!=“novm”]?${RINGTIMER}:"")})
exten => docfb,n,Dial(Local/${CFBEXT}@from-internal/n,${RTCFB},${DIAL_OPTIONS})
exten => docfb,n,Return

; Extensions with no Voicemail box reporting BUSY come here
exten => s-BUSY,1,NoOp(Extension is reporting BUSY and not passing to Voicemail)
exten => s-BUSY,n,Playtones(busy)
exten => s-BUSY,n,Busy(20)

; Anything but BUSY comes here
exten => _s-.,1,Playtones(congestion)
exten => _s-.,n,Congestion(10)

;------------------------------------------------------------------------
; [macro-vm]
;------------------------------------------------------------------------
; CONTEXT: macro-vm
; PURPOSE: call voicemail system and extend with personal ivr
;
; Under normal use, this macro will call the voicemail system with the extension and
; desired greeting mode of busy, unavailable or as specified with direct voicemail
; calls (usually unavailable) when entered from destinations.
;
; The voicemail system’s two greetings have been ‘hijacked’ as follows to extend the
; system by giving the option of a private ‘ivr’ for each voicemail user. The following
; applies to both the busy and unavailable modes of voicemail and can be applied to one
; or both, and differently.
;
; Global Defaults:
;
; The following are default values, used in both busy and unavail modes if no specific
; values are specified.
;
; VMX_REPEAT
; The number of times to repeat the users message if no option is pressed.
; VMX_TIMEOUT
; The timeout to wait after playing message before repeating or giving up.
; VMX_LOOPS
; The number of times it should replay the message and check for an option when
; an invalid option is pressed.
;
; VMX_OPTS_DOVM
; Default voicemail option to use if vm is chosen as an option. No options will
; cause Allison’s generic message, ‘s’ will go straight to beep.
; VMX_OPTS_TIMEOUT
; Default voicemail option to use if it times out with no options. No options will
; cause Allison’s generic message, ‘s’ will go straight to beep.
; IF THE USER PRESSES # - it will look like a timeout as well since no option will
; be presented. If the user wishes to enable a mode where a caller can press #
; during their message and it goes straight to voicemail with only a ‘beep’ then
; this should be set to ‘s’.
; VMX_OPTS_LOOPS
; Default voicemail option to use if to many wrong options occur. No options will
; cause Allison’s generic message, ‘s’ will go straight to beep.
;
; VMX_CONTEXT
; Default context for user destinations if not supplied in the user’s settings
; VMX_PRI
; Default priority for user destinations if not supplied in the user’s settings
;
; VMX_TIMEDEST_CONTEXT
; Default context for timeout destination if not supplied in the user’s settings
; VMX_TIMEDEST_EXT
; Default extension for timeout destination if not supplied in the user’s settings
; VMX_TIMEDEST_PRI
; Default priority for timeout destination if not supplied in the user’s settings
;
; VMX_LOOPDEST_CONTEXT
; Default context for loops destination if not supplied in the user’s settings
; VMX_LOOPDEST_EXT
; Default extension for loops destination if not supplied in the user’s settings
; VMX_LOOPDEST_PRI
; Default priority for loops destination if not supplied in the user’s settings
;
;
; The AMPUSER database variable has been extended with a ‘vmx’ tree (vm-extension). A
; duplicate set is included for both unavail and busy. You could choose for to have an
; ivr when unavail is taken, but not with busy - or a different once with busy.
; The full list is below, each specific entry is futher described:
;
; state: Whether teh current mode is enabled or disabled. Anything but ‘enabled’ is
; treated as disabled.
; repeat: This is the number of times that the users message should be played after the
; timeout if the user has not entered anything. It is just a variable to the
; Read() function which will do the repeating.
; timeout: This is how long to wait after the message has been read for a response from
; the user. A caller can enter a digit any time during the playback.
; loops: This is the number of loops that the system will allow a caller to retry if
; they enter a bad menu choice, before going to the loop failover destination
; vmxopts: This is the vm options to send to the voicemail command used when a specific
; voicemail destination is chosen (inidcated by ‘dovm’ in the ext field). This is
; typically either set to ‘s’ or left blank. When set to ‘s’ there will be no
; message played when entering the voicemail, just a beep. When blank, you will
; have Allison’s generic message played. It is not typical to play the greetings
; since they have been ‘hijacked’ for these IVR’s and from a caller’s perspecitive
; this system appears interconnected with the voicemail so instructions can be
; left there.
; timedest: The three variables: ext, context and pri are the goto destination if the caller
; enters no options and it timesout. None have to be set and a system default
; will be used. If just ext is set, then defaults will be used for context and
; pri, etc.
; loopdest: This is identical to timedest but used if the caller exceeds the maximum invalid
; menu choices.
; [0-9*]: The user can specify up to 11 ivr options, all as single digits from 0-9 or . The
; # key can not be used since it is used as a terminator key for the Read command
; and will never be returned. A minimum of the ext must be specified for each valid
; option and as above, the context and priority can also be specified if the default
; is not to be used.
; Option ‘0’ takes on a special meaning. Since a user is able to break out of the
; voicemail command once entering it with a 0, if specified, the 0 destination will
; be used.
; Option '
’ can also be used to breakout. It is undecided at this point whether
; providing that option will be used as well. (probably should).
;
;
; /AMPUSER//vmx/[busy|unavail]/state: enabled|disabled
; /AMPUSER//vmx/[busy|unavail]/repeat: n (times to repeat message)
; /AMPUSER//vmx/[busy|unavail]/timeout: n (timeout to wait for digit)
; /AMPUSER//vmx/[busy|unavail]/loops: n (loop returies for invalid entries)
; /AMPUSER//vmx/[busy|unavail]/vmxopts/dovm: vmoptions (if ext is dovm)
; /AMPUSER//vmx/[busy|unavail]/vmxopts/timeout: vmoptions (if timeout)
; /AMPUSER//vmx/[busy|unavail]/vmxopts/loops: vmoptions (if loops)
; /AMPUSER//vmx/[busy|unavail]/timedest/ext: extension (if timeout)
; /AMPUSER//vmx/[busy|unavail]/timedest/context: context (if timeout)
; /AMPUSER//vmx/[busy|unavail]/timedest/pri: priority (if timeout)
; /AMPUSER//vmx/[busy|unavail]/loopdest/ext: extension (if too many failures)
; /AMPUSER//vmx/[busy|unavail]/loopdest/context: context (if too many failures)
; /AMPUSER//vmx/[busy|unavail]/loopdest/pri: priority (if too many failures)
; /AMPUSER//vmx/[busy|unavail]/[0-9*]/ext: extension (dovm for vm access)
; /AMPUSER//vmx/[busy|unavail]/[0-9*]/context: context
; /AMPUSER//vmx/[busy|unavail]/[0-9*]/pri: priority
;------------------------------------------------------------------------
[macro-vm]
; ARG1 - extension
; ARG2 - DIRECTDIAL/BUSY
exten => s,1,Macro(user-callerid,SKIPTTL)
exten => s,n,Set(VMGAIN=${IF($[“foo${VM_GAIN}”!=“foo”]?“g(${VM_GAIN})”:"")})
;
; If BLKVM_OVERRIDE is set, then someone told us to block calls from going to
; voicemail. This variable is reset by the answering channel so subsequent
; transfers will properly function.
;
exten => s,n,GotoIf($[“foo${DB(${BLKVM_OVERRIDE})}” != “fooTRUE”]?vmx,1)
;
; we didn’t branch so block this from voicemail
;
exten => s,n,Noop(CAME FROM: ${NODEST} - Blocking VM cause of key: ${DB(BLKVM_OVERRIDE)})

; If vmx not enabled for the current mode,then jump to normal voicemail behavior
; also - if not message (no-msg) is requested, straight to voicemail
;
exten => vmx,1,GotoIf($["${ARG2}"=“NOMESSAGE”]?s-${ARG2},1)
exten => vmx,n,Set(MODE=${IF($["${ARG2}"=“BUSY”]?busy:unavail)})
exten => vmx,n,GotoIf($["${ARG2}" != “DIRECTDIAL”]?notdirect)
exten => vmx,n,Set(MODE=${IF($["${REGEX("[b]" ${VM_DDTYPE})}" = “1”]?busy:${MODE})})
exten => vmx,n(notdirect),Noop(Checking if ext ${ARG1} is enabled: ${DB(AMPUSER/${ARG1}/vmx/${MODE}/state)})
exten => vmx,n,GotoIf($["${DB(AMPUSER/${ARG1}/vmx/${MODE}/state)}" != “enabled”]?s-${ARG2},1)

; If the required voicemail file does not exist, then abort and go to normal voicemail behavior
;
; TODO: there have been errors using System() with jump to 101 where asterisk works fine at the begining and
; then starts to jump to 101 even on success. This new mode is being tried with the SYSTEM Status which
; returns SUCCESS when the command returned succcessfully with a 0 app return code.
;
exten => vmx,n,Macro(get-vmcontext,${ARG1})
;exten => vmx,n,TrySystem(/bin/ls ${ASTSPOOLDIR}/voicemail/${VMCONTEXT}/${ARG1}/${MODE}.[wW][aA][vV])
exten => vmx,n,AGI(checksound.agi,${ASTSPOOLDIR}/voicemail/${VMCONTEXT}/${ARG1}/${MODE})
exten => vmx,n,GotoIf($["${SYSTEMSTATUS}" != “SUCCESS”]?nofile)

; Get the repeat, timeout and loop times to use if they are overriden form the global settings
;
exten => vmx,n,Set(LOOPCOUNT=0)
exten => vmx,n,GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/repeat)}" = “0”]?vmxtime)
exten => vmx,n,Set(VMX_REPEAT=${DB_RESULT})
exten => vmx,n(vmxtime),GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/timeout)}" = “0”]?vmxloops)
exten => vmx,n,Set(VMX_TIMEOUT=${DB_RESULT})
exten => vmx,n(vmxloops),GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/loops)}" = “0”]?vmxanswer)
exten => vmx,n,Set(VMX_LOOPS=${DB_RESULT})
exten => vmx,n(vmxanswer),Answer()

; Now play the users voicemail recording as the basis for their ivr, the Read command will repeat as needed and if it timesout
; then we go to the timeout. Otherwise handle invalid options by looping until the limit until a valid option is played.
;
exten => vmx,n(loopstart),Read(ACTION,${ASTSPOOLDIR}/voicemail/${VMCONTEXT}/${ARG1}/${MODE},1,skip,${VMX_REPEAT},${VMX_TIMEOUT})
exten => vmx,n,GotoIf($["${EXISTS(${ACTION})}" = “1”]?checkopt)

; If we are here we timed out, go to the required destination
;
exten => vmx,n(noopt),Noop(Timeout: going to timeout dest)
exten => vmx,n,Set(VMX_OPTS=${VMX_OPTS_TIMEOUT})
exten => vmx,n,GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/vmxopts/timeout)}" = “0”]?chktime)
exten => vmx,n,Set(VMX_OPTS=${DB_RESULT})
exten => vmx,n(chktime),GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/timedest/ext)}" = “0”]?dotime)
exten => vmx,n,Set(VMX_TIMEDEST_EXT=${DB_RESULT})
exten => vmx,n,GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/timedest/context)}" = “0”]?timepri)
exten => vmx,n,Set(VMX_TIMEDEST_CONTEXT=${DB_RESULT})
exten => vmx,n(timepri),GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/timedest/pri)}" = “0”]?dotime)
exten => vmx,n,Set(VMX_TIMEDEST_PRI=${DB_RESULT})
exten => vmx,n(dotime),Goto(${VMX_TIMEDEST_CONTEXT},${VMX_TIMEDEST_EXT},${VMX_TIMEDEST_PRI})

; We got an option, check if the option is defined, or one of the system defaults
;
exten => vmx,n(checkopt),GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/${ACTION}/ext)}" = “1”]?doopt)
exten => vmx,n,GotoIf($["${ACTION}" = “0”]?o,1)
exten => vmx,n,GotoIf($["${ACTION}" = “*”]?adef,1)

; Got invalid option loop until the max
;
exten => vmx,n,Set(LOOPCOUNT=$[${LOOPCOUNT} + 1])
exten => vmx,n,GotoIf($[${LOOPCOUNT} > ${VMX_LOOPS}]?toomany)
exten => vmx,n,Playback(pm-invalid-option&please-try-again)
exten => vmx,n,Goto(loopstart)

; tomany: to many invalid options, go to the specified destination
;
exten => vmx,n(toomany),Noop(Too Many invalid entries, got to invalid dest)
exten => vmx,n,Set(VMX_OPTS=${VMX_OPTS_LOOPS})
exten => vmx,n,GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/vmxopts/loops)}" = “0”]?chkloop)
exten => vmx,n,Set(VMX_OPTS=${DB_RESULT})
exten => vmx,n(chkloop),GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/loopdest/ext)}" = “0”]?doloop)
exten => vmx,n,Set(VMX_LOOPDEST_EXT=${DB_RESULT})
exten => vmx,n,GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/loopdest/context)}" = “0”]?looppri)
exten => vmx,n,Set(VMX_LOOPDEST_CONTEXT=${DB_RESULT}) ;TODO make configurable per above
exten => vmx,n(looppri),GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/loopdest/pri)}" = “0”]?doloop)
exten => vmx,n,Set(VMX_LOOPDEST_PRI=${DB_RESULT}) ;TODO make configurable per above
exten => vmx,n(doloop),Goto(${VMX_LOOPDEST_CONTEXT},${VMX_LOOPDEST_EXT},${VMX_LOOPDEST_PRI})

; doopt: execute the valid option that was chosen
;
exten => vmx,n(doopt),Noop(Got a valid option: ${DB_RESULT})
exten => vmx,n,Set(VMX_EXT=${DB_RESULT})
;
; Special case, if this option was to go to voicemail, set options and go
;
exten => vmx,n,GotoIf($["${VMX_EXT}" != “dovm”]?getdest)
exten => vmx,n(vmxopts),Set(VMX_OPTS=${VMX_OPTS_DOVM})
exten => vmx,n,GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/vmxopts/dovm)}" = “0”]?vmxdovm)
exten => vmx,n(vmxopts),Set(VMX_OPTS=${DB_RESULT})
exten => vmx,n(vmxdovm),goto(dovm,1)
;
; General case, setup the goto destination and go there (no error checking, its up to the GUI’s to assure
; reasonable values
;
exten => vmx,n(getdest),GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/${ACTION}/context)}" = “0”]?vmxpri)
exten => vmx,n,Set(VMX_CONTEXT=${DB_RESULT})
exten => vmx,n(vmxpri),GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/${ACTION}/pri)}" = “0”]?vmxgoto)
exten => vmx,n,Set(VMX_PRI=${DB_RESULT})
exten => vmx,n(vmxgoto),Goto(${VMX_CONTEXT},${VMX_EXT},${VMX_PRI})

; If the required voicemail file is not present, then revert to normal voicemail
; behavior treating as if it was not set
;
exten => vmx,n(nofile),Noop(File for mode: ${MODE} does not exist, SYSTEMSTATUS: ${SYSTEMSTATUS}, going to normal voicemail)
exten => vmx,n,Goto(s-${ARG2},1)

; Drop into voicemail either as a direct destination (in which case VMX_OPTS might be set to something) or
; if the user timed out or broke out of the loop then VMX_OPTS is always cleared such that an Allison
; message is played and the caller know’s what is going on.
;
exten => dovm,1,Noop(VMX Timeout - go to voicemail)
exten => dovm,n,Voicemail(${ARG1}@${VMCONTEXT},${VMX_OPTS}${VMGAIN}) ; no flags, so allison plays please leave …
exten => dovm,n,Goto(exit-${VMSTATUS},1)

exten => s-BUSY,1,NoOp(BUSY voicemail)
exten => s-BUSY,n,Macro(get-vmcontext,${ARG1})
exten => s-BUSY,n,Voicemail(${ARG1}@${VMCONTEXT},${VM_OPTS}b${VMGAIN}) ; Voicemail Busy message
exten => s-BUSY,n,Goto(exit-${VMSTATUS},1)

exten => s-NOMESSAGE,1,NoOp(NOMESSAGE (beeb only) voicemail)
exten => s-NOMESSAGE,n,Macro(get-vmcontext,${ARG1})
exten => s-NOMESSAGE,n,Voicemail(${ARG1}@${VMCONTEXT},${VM_OPTS}${VMGAIN}) ; Voicemail Busy message
exten => s-NOMESSAGE,n,Goto(exit-${VMSTATUS},1)

exten => s-DIRECTDIAL,1,NoOp(DIRECTDIAL voicemail)
exten => s-DIRECTDIAL,n,Macro(get-vmcontext,${ARG1})
exten => s-DIRECTDIAL,n,Voicemail(${ARG1}@${VMCONTEXT},${VM_OPTS}${VM_DDTYPE}${VMGAIN})
exten => s-DIRECTDIAL,n,Goto(exit-${VMSTATUS},1)

exten => _s-.,1,Macro(get-vmcontext,${ARG1})
exten => _s-.,n,Voicemail(${ARG1}@${VMCONTEXT},${VM_OPTS}u${VMGAIN}) ; Voicemail Unavailable message
exten => _s-.,n,Goto(exit-${VMSTATUS},1)

; If the user has a 0 option defined, use that for operator zero-out from within voicemail
; as well to keep it consistant with the menu structure
;
exten => o,1,Background(one-moment-please) ; 0 during vm message will hangup
exten => o,n,GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/0/ext)}" = “0”]?doopdef)

exten => o,n,Set(VMX_OPDEST_EXT=${DB_RESULT})
exten => o,n,GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/0/context)}" = “1”]?opcontext)
exten => o,n,Set(DB_RESULT=${VMX_CONTEXT})
exten => o,n(opcontext),Set(VMX_OPDEST_CONTEXT=${DB_RESULT})
exten => o,n,GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/0/pri)}" = “1”]?oppri)
exten => o,n,Set(DB_RESULT=${VMX_PRI})
exten => o,n(oppri),Set(VMX_OPDEST_PRI=${DB_RESULT})

exten => o,n,Goto(${VMX_OPDEST_CONTEXT},${VMX_OPDEST_EXT},${VMX_OPDEST_PRIORITY})
exten => o,n(doopdef),GotoIf($[“x${OPERATOR_XTN}”=“x”]?nooper:from-internal,${OPERATOR_XTN},1)
exten => o,n(nooper),GotoIf($[“x${FROM_DID}”=“x”]?nodid)
exten => o,n,Dial(Local/${FROM_DID)@from-pstn)
exten => o,n,Macro(hangup)
exten => o,n(nodid),Dial(Local/s@from-pstn)
exten => o,n,Macro(hangup)

; If the user has a * option defined, use that for the * out from within voicemail
; as well to keep it consistant with the menu structure
;
exten => a,1,Macro(get-vmcontext,${ARG1})
exten => a,n,GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/*/ext)}" = “0”]?adef,1)

exten => a,n,Set(VMX_ADEST_EXT=${DB_RESULT})
exten => a,n,GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}//context)}" = “1”]?acontext)
exten => a,n,Set(DB_RESULT=${VMX_CONTEXT})
exten => a,n(acontext),Set(VMX_ADEST_CONTEXT=${DB_RESULT})
exten => a,n,GotoIf($["${DB_EXISTS(AMPUSER/${ARG1}/vmx/${MODE}/
/pri)}" = “1”]?apri)
exten => a,n,Set(DB_RESULT=${VMX_PRI})
exten => a,n(apri),Set(VMX_ADEST_PRI=${DB_RESULT})
exten => a,n,Goto(${VMX_ADEST_CONTEXT},${VMX_ADEST_EXT},${VMX_ADEST_PRI})

exten => adef,1,VoiceMailMain(${ARG1}@${VMCONTEXT})
exten => adef,n,Hangup

exten => exit-FAILED,1,Playback(im-sorry&an-error-has-occured)
exten => exit-FAILED,n,Hangup()

exten => exit-SUCCESS,1,Playback(goodbye)
exten => exit-SUCCESS,n,Hangup()

exten => exit-USEREXIT,1,Playback(goodbye)
exten => exit-USEREXIT,n,Hangup()

exten => t,1,Hangup()
;------------------------------------------------------------------------

;------------------------------------------------------------------------
; [macro-simple-dial]
;------------------------------------------------------------------------
; This macro was derived from macro-exten-vm, which is what is normally used to
; ring an extension. It has been simplified and designed to never go to voicemail
; and always return regardless of the DIALSTATUS for any incomplete call.
;
; It’s current primary purpose is to allow findmefollow ring an extension prior
; to trying the follow-me ringgroup that is provided.
;
; Ring an extension, if the extension is busy or there is no answer, return
; ARGS: $EXTENSION, $RINGTIME
;------------------------------------------------------------------------
[macro-simple-dial]
exten => s,1,Macro(user-callerid,SKIPTTL) ; already called from follow-me

; FROMCONTEXT was in the original macro-exten-vm where this macro was derived from. A
; search through all the modules does not come up with any place using this
; variable, but it is left here as a reminder in case there is functionality
; that eventually behaves in a certain way as a result of this variable being set
; and this macro has to masquerade as exten-vm.
;
exten => s,n,Set(EXTTOCALL=${ARG1})
exten => s,n,Set(RT=${ARG2})
exten => s,n,Set(CFUEXT=${DB(CFU/${EXTTOCALL})})
exten => s,n,Set(CFBEXT=${DB(CFB/${EXTTOCALL})})
exten => s,n,Macro(record-enable,${EXTTOCALL},IN)

exten => s,n,Macro(dial,${RT},${DIAL_OPTIONS},${EXTTOCALL})

exten => s,n,Set(PR_DIALSTATUS=${DIALSTATUS})

; if we return, thus no answer, and they have a CFU setting, then we try that next
;
exten => s,n,GosubIf($[$["${PR_DIALSTATUS}"=“NOANSWER”] & $[“foo${CFUEXT}”!=“foo”]]?docfu,1) ; check for CFU in use on no answer
exten => s,n,GosubIf($[$["${PR_DIALSTATUS}"=“BUSY”] & $[“foo${CFBEXT}”!=“foo”]]?docfb,1) ; check for CFB in use on busy
exten => s,n,Set(DIALSTATUS=${PR_DIALSTATUS})

; Nothing yet, then go to the end (which will just return, but in case we decide to do something with certain
; return situations, this is left in.
;
exten => s,n,Goto(s-${DIALSTATUS},1)

; Try the Call Forward on No Answer / Unavailable number.
; We want to try CFU if set, but we want the same ring timer as was set to our call (or do we want the
; system ringtimer? - probably not). Then if no answer there (assuming it doesn’t drop into their vm or
; something we return, which will have the net effect of returning to the followme setup.)
;
; want to avoid going to other follow-me settings here. So check if the CFUEXT is a user and if it is
; then direct it straight to ext-local (to avoid getting intercepted by findmefollow) otherwise send it
; to from-internal since it may be an outside line.
;
exten => docfu,1,GotoIf( $[ “foo${DB(AMPUSER/${CFUEXT}/device)}” = “foo” ]?chlocal)
exten => docfu,n,Dial(Local/${CFUEXT}@ext-local,${RT},${DIAL_OPTIONS})
exten => docfu,n,Return
exten => docfu,n(chlocal),Dial(Local/${CFUEXT}@from-internal/n,${RT},${DIAL_OPTIONS})
exten => docfu,n,Return

; Try the Call Forward on Busy number
exten => docfb,1,GotoIf( $[ “foo${DB(AMPUSER/${CFBEXT}/device)}” = “foo” ]?chlocal)
exten => docfb,n,Dial(Local/${CFBEXT}@ext-local,${RT},${DIAL_OPTIONS})
exten => docfb,n,Return
exten => docfb,n(chlocal),Dial(Local/${CFBEXT}@from-internal/n,${RT},${DIAL_OPTIONS})
exten => docfb,n,Return

; In all cases of no connection, come here and simply return, since the calling dialplan will
; decide what to do next
exten => _s-.,1,NoOp(Extension is reporting ${EXTEN})
;------------------------------------------------------------------------

; get the voicemail context for the user in ARG1
[macro-get-vmcontext]
exten => s,1,Set(VMCONTEXT=${DB(AMPUSER/${ARG1}/voicemail)})
exten => s,2,GotoIf($[“foo${VMCONTEXT}” = “foo”]?200:300)
exten => s,200,Set(VMCONTEXT=default)
exten => s,300,NoOp()

; For some reason, if I don’t run setCIDname, CALLERID(name) will be blank in my AGI
; ARGS: none
[macro-fixcid]
exten => s,1,Set(CALLERID(name)=${CALLERID(name)})

; Ring groups of phones
; ARGS: comma separated extension list
; 1 - Ring Group Strategy
; 2 - ringtimer
; 3 - prefix
; 4 - extension list
[macro-rg-group]
exten => s,1,Macro(user-callerid,SKIPTTL) ; already called from ringgroup
exten => s,2,GotoIf($["${CALLERID(name):0:${LEN(${RGPREFIX})}}" != “${RGPREFIX}”]?4:3) ; check for old prefix
exten => s,3,Set(CALLERID(name)=${CALLERID(name):${LEN(${RGPREFIX})}}) ; strip off old prefix
exten => s,4,Set(RGPREFIX=${ARG3}) ; set new prefix
exten => s,5,Set(CALLERID(name)=${RGPREFIX}${CALLERID(name)}) ; add prefix to callerid name
exten => s,6,Set(RecordMethod=Group) ; set new prefix
exten => s,7,Macro(record-enable,${MACRO_EXTEN},${RecordMethod})
exten => s,8,Set(RingGroupMethod=${ARG1}) ;
exten => s,9,Macro(dial,${ARG2},${DIAL_OPTIONS},${ARG4})
exten => s,10,Set(RingGroupMethod=’’) ;

;
; Outgoing channel(s) are busy … inform the client
; but use noanswer features like ringgroups don’t break by being answered
; just to play the message.
;
[macro-outisbusy]
exten => s,1,Playback(all-circuits-busy-now,noanswer)
exten => s,n,Playback(pls-try-call-later,noanswer)
exten => s,n,Macro(hangupcall)

; What to do on hangup.
[macro-hangupcall]
exten => s,1,ResetCDR(w)
exten => s,n,NoCDR()

; Cleanup any remaining RG flag
;
exten => s,n,GotoIf($[ “x${USE_CONFIRMATION}” = “x” | “x${RINGGROUP_INDEX}” = “x” | “${CHANNEL}” != “${UNIQCHAN}”]?skiprg)
exten => s,n,Noop(Cleaning Up Confirmation Flag: RG/${RINGGROUP_INDEX}/${CHANNEL})
exten => s,n,DBDel(RG/${RINGGROUP_INDEX}/${CHANNEL})

; Cleanup any remaining BLKVM flag
;
exten => s,n(skiprg),GotoIf($[ “x${BLKVM_BASE}” = “x” | “BLKVM/${BLKVM_BASE}/${CHANNEL}” != “${BLKVM_OVERRIDE}” ]?skipblkvm)
exten => s,n,Noop(Cleaning Up Block VM Flag: ${BLKVM_OVERRIDE})
exten => s,n,DBDel(${BLKVM_OVERRIDE})

; Cleanup any remaining FollowMe DND flags
;
exten => s,n(skipblkvm),GotoIf($[ “x${FMGRP}” = “x” | “x${FMUNIQUE}” = “x” | “${CHANNEL}” != “${FMUNIQUE}” ]?theend)
exten => s,n,DBDel(FM/DND/${FMGRP}/${CHANNEL})

exten => s,n(theend),Hangup

[macro-faxreceive]
exten => s,1,Set(FAXFILE=${ASTSPOOLDIR}/fax/${UNIQUEID}.tif)
exten => s,2,Set(EMAILADDR=${FAX_RX_EMAIL})
exten => s,3,rxfax(${FAXFILE})
exten => s,103,Set(EMAILADDR=${FAX_RX_EMAIL})
exten => s,104,Goto(3)

; dialout and strip the prefix
[macro-dialout]
exten => s,1,Macro(user-callerid,SKIPTTL)
exten => s,2,GotoIf($["${ECID${CALLERID(number)}}" = “”]?5) ;check for CID override for exten
exten => s,3,Set(CALLERID(all)=${ECID${CALLERID(number)}})
exten => s,4,Goto(7)
exten => s,5,GotoIf($["${OUTCID_${ARG1}}" = “”]?7) ;check for CID override for trunk
exten => s,6,Set(CALLERID(all)=${OUTCID_${ARG1}})
exten => s,7,Set(length=${LEN(${DIAL_OUT_${ARG1}})})
exten => s,8,Dial(${OUT_${ARG1}}/${ARG2:${length}})
exten => s,9,Playtones(congestion)
exten => s,10,Congestion(5)
exten => s,109,Macro(outisbusy)

; dialout using default OUT trunk - no prefix
[macro-dialout-default]
exten => s,1,Macro(user-callerid,SKIPTTL)
exten => s,2,Macro(record-enable,${CALLERID(number)},OUT)
exten => s,3,Macro(outbound-callerid,${ARG1})
exten => s,4,Dial(${OUT}/${ARG1})
exten => s,5,Playtones(congestion)
exten => s,6,Congestion(5)
exten => s,105,Macro(outisbusy)

; dialout using a trunk, using pattern matching (don’t strip any prefix)
; arg1 = trunk number, arg2 = number, arg3 = route password
;
; MODIFIED (PL)
;
; Modified both Dial() commands to include the new TRUNK_OPTIONS from the general
; screen of AMP
;
[macro-dialout-trunk]
exten => s,1,Set(DIAL_TRUNK=${ARG1})
exten => s,n,Set(DIAL_NUMBER=${ARG2})
exten => s,n,Set(ROUTE_PASSWD=${ARG3})

exten => s,n,GotoIf($["${ROUTE_PASSWD}" = “”]?noauth) ; arg3 is pattern password
exten => s,n(auth),Authenticate(${ROUTE_PASSWD})
exten => s,n(noauth),GotoIf($[“x${OUTDISABLE_${ARG1}}” = “xon”]?disabletrunk,1)

; If NODEST is set, clear it. No point in remembering since dialout-trunk will just end in the
; bit bucket. But if answered by an outside line with transfer capability, we want NODEST to be
; clear so a subsequent transfer to an internal extension works and goes to voicmail or other
; destinations.
;
exten => s,n,Set(_NODEST=)

exten => s,n,Set(DIAL_TRUNK_OPTIONS=${DIAL_OPTIONS}) // will be reset to TRUNK_OPTIONS if not intra-company
exten => s,n,Set(GROUP()=OUT_${DIAL_TRUNK})
exten => s,n,Macro(user-callerid,SKIPTTL)
exten => s,n,Macro(record-enable,${CALLERID(number)},OUT)
exten => s,n,GotoIf($["${INTRACOMPANYROUTE}" = “YES”]?skipoutcid) ;Set to YES if treated like internal
exten => s,n,Set(DIAL_TRUNK_OPTIONS=${TRUNK_OPTIONS})
exten => s,n,Macro(outbound-callerid,${DIAL_TRUNK})
exten => s,n(skipoutcid),GotoIf($["${OUTMAXCHANS_${DIAL_TRUNK}}foo" = “foo”]?nomax)
exten => s,n(checkmax),GotoIf($[ ${GROUP_COUNT()} > ${OUTMAXCHANS_${DIAL_TRUNK}} ]?chanfull)
exten => s,n(nomax),AGI(fixlocalprefix) ; this sets DIAL_NUMBER to the proper dial string for this trunk
exten => s,n,Set(OUTNUM=${OUTPREFIX_${DIAL_TRUNK}}${DIAL_NUMBER}) ; OUTNUM is the final dial number
exten => s,n,Set(custom=${CUT(OUT_${DIAL_TRUNK},:,1)}) ; Custom trunks are prefixed with “AMP:”

; Back to normal processing, whether intracompany or not.
; But add the macro-setmusic if we don’t want music on this outbound call
;
exten => s,n,GotoIf($[$["${MOHCLASS}" = “default”] | $[“foo${MOHCLASS}” = “foo”]]?gocall) ; Set to YES if we should pump silence
exten => s,n,Set(DIAL_TRUNK_OPTIONS=M(setmusic^${MOHCLASS})${DIAL_TRUNK_OPTIONS}) ; set MoH or off

exten => s,n(gocall),GotoIf($["${custom}" = “AMP”]?customtrunk)
exten => s,n,Dial(${OUT_${DIAL_TRUNK}}/${OUTNUM},300,${DIAL_TRUNK_OPTIONS}) ; Regular Trunk Dial
exten => s,n,Goto(s-${DIALSTATUS},1)
exten => s,n(customtrunk),Set(pre_num=${CUT(OUT_${DIAL_TRUNK},$,1)})
exten => s,n,Set(the_num=${CUT(OUT_${DIAL_TRUNK},$,2)}) ; this is where we expect to find string OUTNUM
exten => s,n,Set(post_num=${CUT(OUT_${DIAL_TRUNK},$,3)})
exten => s,n,GotoIf($["${the_num}" = “OUTNUM”]?outnum:skipoutnum) ; if we didn’t find “OUTNUM”, then skip to Dial
exten => s,n(outnum),Set(the_num=${OUTNUM}) ; replace “OUTNUM” with the actual number to dial
exten => s,n(skipoutnum),Dial(${pre_num:4}${the_num}${post_num},300,${DIAL_TRUNK_OPTIONS})
exten => s,n,Goto(s-${DIALSTATUS},1)

exten => s,n(chanfull),Noop(max channels used up)

exten => s-BUSY,1,NoOp(Dial failed due to trunk reporting BUSY - giving up)
exten => s-BUSY,2,Busy(20)

exten => s-NOANSWER,1,NoOp(Dial failed due to trunk reporting NOANSWER - giving up)
exten => s-NOANSWER,2,Playtones(congestion)
exten => s-NOANSWER,3,Congestion(20)

exten => s-CANCEL,1,NoOp(Dial failed due to trunk reporting CANCEL - giving up)
exten => s-CANCEL,2,Playtones(congestion)
exten => s-CANCEL,3,Congestion(20)

exten => s-.,1,GotoIf($["x${OUTFAIL${ARG1}}" = “x”]?noreport)
exten => s-.,n,AGI(${OUTFAIL${ARG1}})
exten => _s-.,n(noreport),Noop(TRUNK Dial failed due to ${DIALSTATUS} - failing through to other trunks)

exten => disabletrunk,1,Noop(TRUNK: ${OUT_${DIAL_TRUNK}} DISABLED - falling through to next trunk)

exten => h,1,Macro(hangupcall)

; Adds a dynamic agent/member to a Queue
; Prompts for call-back number - in not entered, uses CIDNum
[macro-agent-add]
exten => s,1,Wait(1)
exten => s,2,Macro(user-callerid,SKIPTTL)
exten => s,3,Read(CALLBACKNUM,agent-user) ; get callback number from user
exten => s,4,GotoIf($["${CALLBACKNUM}" = “”]?5:7) ; if user just pressed # or timed out, use cidnum
exten => s,5,Set(CALLBACKNUM=${CALLERID(number)})
exten => s,6,GotoIf($["${CALLBACKNUM}" = “”]?2) ; if still no number, start over
exten => s,7,GotoIf($["${ARG2}" = “”]?9:8) ; arg2 is queue password
exten => s,8,Authenticate(${ARG2})
exten => s,9,AddQueueMember(${ARG1},Local/${CALLBACKNUM}@from-internal/n) ; using chan_local allows us to have agents over trunks
exten => s,10,UserEvent(Agentlogin,Agent: ${CALLBACKNUM})
exten => s,11,Wait(1)
exten => s,12,Playback(agent-loginok)
exten => s,13,Hangup()

; Removes a dynamic agent/member from a Queue
; Prompts for call-back number - in not entered, uses CIDNum
[macro-agent-del]
exten => s,1,Wait(1)
exten => s,2,Macro(user-callerid,SKIPTTL)
exten => s,3,Read(CALLBACKNUM,agent-user) ; get callback number from user
exten => s,4,GotoIf($["${CALLBACKNUM}" = “”]?5:7) ; if user just pressed # or timed out, use cidnum
exten => s,5,Set(CALLBACKNUM=${CALLERID(number)})
exten => s,6,GotoIf($["${CALLBACKNUM}" = “”]?2) ; if still no number, start over
exten => s,7,RemoveQueueMember(${ARG1},Local/${CALLBACKNUM}@from-internal/n)
exten => s,8,UserEvent(RefreshQueue)
exten => s,9,Wait(1)
exten => s,10,Playback(agent-loggedoff)
exten => s,11,Hangup()

; arg1 = trunk number, arg2 = number
[macro-dialout-enum]
; Re-written to use enumlookup.agi
exten => s,1,GotoIf($["${ARG3}" != “”]?PASSWD:NOPASSWD); arg3 is pattern password
exten => s,n(PASSWD),Authenticate(${ARG3})
exten => s,n(NOPASSWD),Macro(user-callerid,SKIPTTL)
exten => s,n,Macro(record-enable,${CALLERID(number)},OUT)
exten => s,n,Macro(outbound-callerid,${ARG1})
exten => s,n,Set(GROUP()=OUT_${ARG1})
exten => s,n,GotoIf($[ ${GROUP_COUNT()} > ${OUTMAXCHANS_${ARG1}} ]?nochans)
exten => s,n,Set(DIAL_NUMBER=${ARG2})
exten => s,n,Set(DIAL_TRUNK=${ARG1})
exten => s,n,AGI(fixlocalprefix) ; this sets DIAL_NUMBER to the proper dial string for this trunk
; Replacement for asterisk’s ENUMLOOKUP function
exten => s,n,AGI(enumlookup.agi)
; Now we have the variable DIALARR set to a list of URI’s that can be called, in order of priority
; Loop through them trying them in order.
exten => s,n(dialloop),GotoIf($[“foo${DIALARR}”=“foo”]?end)
exten => s,n,Set(TRYDIAL=${CUT(DIALARR,%,1)})
exten => s,n,Set(DIALARR=${CUT(DIALARR,%,2-)})
exten => s,n,Dial(${TRYDIAL})
exten => s,n,NoOp(Dial exited in macro-enum-dialout with ${DIALSTATUS})

; Now, if we’re still here, that means the Dial failed for some reason.
; If it’s CONGESTION or CHANUNAVAIL we want to try again on a different
; different channel. If there’s no more left, the dialloop tag will exit.
exten => s,n,GotoIf($[ $[ “${DIALSTATUS}” = “CHANUNAVAIL” ] | $[ “${DIALSTATUS}” = “CONGESTION” ] ]?dialloop)

; If we’re here, then it’s BUSY or NOANSWER or something and well, deal with it.
exten => s,n(dialfailed),Goto(s-${DIALSTATUS},1)

; Here are the exit points for the macro.

exten => s,n(nochans),NoOp(max channels used up)

exten => s,n(end),NoOp(Exiting macro-dialout-enum)

exten => s-BUSY,1,NoOp(Trunk is reporting BUSY)
exten => s-BUSY,2,Busy(20)

exten => _s-.,1,NoOp(Dial failed due to ${DIALSTATUS})

[macro-record-enable]
exten => s,1,GotoIf($[${LEN(${BLINDTRANSFER})} > 0]?2:4)
exten => s,2,ResetCDR(w)
exten => s,3,StopMonitor()
exten => s,4,AGI(recordingcheck,${STRFTIME(${EPOCH},%Y%m%d-%H%M%S)},${UNIQUEID})
exten => s,5,Noop(No recording needed)
exten => s,999,MixMonitor(${CALLFILENAME}.wav)

;exten => s,3,BackGround(for-quality-purposes)
;exten => s,4,BackGround(this-call-may-be)
;exten => s,5,BackGround(recorded)

; This macro is for dev purposes and just dumps channel/app variables. Useful when designing new contexts.
[macro-dumpvars]
exten => s,1,Noop(ACCOUNTCODE=${ACCOUNTCODE})
exten => s,2,Noop(ANSWEREDTIME=${ANSWEREDTIME})
exten => s,3,Noop(BLINDTRANSFER=${BLINDTRANSFER})
exten => s,4,Noop(CALLERID=${CALLERID(all)})
exten => s,5,Noop(CALLERID(name)=${CALLERID(name)})
exten => s,6,Noop(CALLERID(number)=${CALLERID(number)})
exten => s,7,Noop(CALLINGPRES=${CALLINGPRES})
exten => s,8,Noop(CHANNEL=${CHANNEL})
exten => s,9,Noop(CONTEXT=${CONTEXT})
exten => s,10,Noop(DATETIME=${DATETIME})
exten => s,11,Noop(DIALEDPEERNAME=${DIALEDPEERNAME})
exten => s,12,Noop(DIALEDPEERNUMBER=${DIALEDPEERNUMBER})
exten => s,13,Noop(DIALEDTIME=${DIALEDTIME})
exten => s,14,Noop(DIALSTATUS=${DIALSTATUS})
exten => s,15,Noop(DNID=${DNID})
exten => s,16,Noop(EPOCH=${EPOCH})
exten => s,17,Noop(EXTEN=${EXTEN})
exten => s,18,Noop(HANGUPCAUSE=${HANGUPCAUSE})
exten => s,19,Noop(INVALID_EXTEN=${INVALID_EXTEN})
exten => s,20,Noop(LANGUAGE=${LANGUAGE})
exten => s,21,Noop(MEETMESECS=${MEETMESECS})
exten => s,22,Noop(PRIORITY=${PRIORITY})
exten => s,23,Noop(RDNIS=${RDNIS})
exten => s,24,Noop(SIPDOMAIN=${SIPDOMAIN})
exten => s,25,Noop(SIP_CODEC=${SIP_CODEC})
exten => s,26,Noop(SIPCALLID=${SIPCALLID})
exten => s,27,Noop(SIPUSERAGENT=${SIPUSERAGENT})
exten => s,29,Noop(TXTCIDNAME=${TXTCIDNAME})
exten => s,30,Noop(UNIQUEID=${UNIQUEID})
exten => s,31,Noop(TOUCH_MONITOR=${TOUCH_MONITOR})
exten => s,32,Noop(MACRO_CONTEXT=${MACRO_CONTEXT})
exten => s,33,Noop(MACRO_EXTEN=${MACRO_EXTEN})
exten => s,34,Noop(MACRO_PRIORITY=${MACRO_PRIORITY})

[macro-user-logon]
; check device type
exten => s,1,Set(DEVICETYPE=${DB(DEVICE/${CALLERID(number)}/type)})
exten => s,2,GotoIf($["${DEVICETYPE}" = “fixed”]?s-FIXED,1)
; get user’s extension
exten => s,3,Set(AMPUSER=${ARG1})
exten => s,4,GotoIf($["${AMPUSER}" = “”]?5:9)
exten => s,5,BackGround(please-enter-your)
exten => s,6,Playback(extension)
exten => s,7,Read(AMPUSER,then-press-pound)
; get user’s password and authenticate
exten => s,8,Wait(1)
exten => s,9,Set(AMPUSERPASS=${DB(AMPUSER/${AMPUSER}/password)})
exten => s,10,GotoIf($[${LEN(${AMPUSERPASS})} = 0]?s-NOPASSWORD,1)
; do not continue if the user has already logged onto this device
exten => s,11,Set(DEVICEUSER=${DB(DEVICE/${CALLERID(number)}/user)})
exten => s,12,GotoIf($["${DEVICEUSER}" = “${AMPUSER}”]?s-ALREADYLOGGEDON,1)
exten => s,13,Authenticate(${AMPUSERPASS})
; devices can only be mapped to one user - loggoff anyone else who is here
exten => s,14,Macro(user-logoff)
; map user to device
exten => s,15,Set(AMPUSERDEVICES=${DB(AMPUSER/${AMPUSER}/device)})
exten => s,16,GotoIf($[${LEN(${AMPUSERDEVICES})} = 0]?18)
exten => s,17,Set(AMPUSERDEVICES=${AMPUSERDEVICES}&)
exten => s,18,Set(AMPUSERDEVICES=${AMPUSERDEVICES}${CALLERID(number)})
exten => s,19,Set(DB(AMPUSER/${AMPUSER}/device)=${AMPUSERDEVICES})
; map device to user
exten => s,20,Set(DB(DEVICE/${CALLERID(number)}/user)=${AMPUSER})
; create symlink from dummy device mailbox to user’s mailbox
exten => s,21,System(/bin/ln -s ${ASTSPOOLDIR}/voicemail/default/${AMPUSER}/ ${ASTSPOOLDIR}/voicemail/device/${CALLERID(number)})

exten => s-FIXED,1,NoOp(Device is FIXED and cannot be logged into)
exten => s-FIXED,2,Playback(ha/phone)
exten => s-FIXED,3,SayDigits(${CALLERID(number)})
exten => s-FIXED,4,Playback(is-curntly-unavail)
exten => s-FIXED,5,Playback(vm-goodbye)
exten => s-FIXED,6,Hangup ;TODO should play msg indicated device cannot be logged into

exten => s-ALREADYLOGGEDON,1,NoOp(This device has already been logged into by this user)
exten => s-ALREADYLOGGEDON,2,Playback(vm-goodbye)
exten => s-ALREADYLOGGEDON,3,Hangup ;TODO should play msg indicated device is already logged into

exten => s-NOPASSWORD,1,NoOp(This extension does not exist or no password is set)
exten => s-NOPASSWORD,2,Playback(an-error-has-occured)
exten => s-NOPASSWORD,3,Playback(vm-goodbye)
exten => s-NOPASSWORD,4,Hangup ;TODO should play msg indicated device is already logged into

[macro-user-logoff]
; check device type
exten => s,1,Set(DEVICETYPE=${DB(DEVICE/${CALLERID(number)}/type)})
exten => s,2,GotoIf($["${DEVICETYPE}" = “fixed”]?s-FIXED,1)
; remove entry from user’s DEVICE key
; delete the symlink to user’s voicemail box
exten => s,3,System(rm -f ${ASTSPOOLDIR}/voicemail/device/${CALLERID(number)})
exten => s,4,Set(DEVAMPUSER=${DB(DEVICE/${CALLERID(number)}/user)})
exten => s,5,Set(AMPUSERDEVICES=${DB(AMPUSER/${DEVAMPUSER}/device)})
exten => s,6,AGI(list-item-remove.php,${AMPUSERDEVICES},${CALLERID(number)},AMPUSERDEVICES,&)
; reset user -> device mapping
; users can log onto multiple devices, need to just remove device from value
exten => s,7,Set(DB(AMPUSER/${DEVAMPUSER}/device)=${AMPUSERDEVICES})
; reset device -> user mapping
exten => s,8,Set(DB(DEVICE/${CALLERID(number)}/user)=none)
exten => s,9,Playback(vm-goodbye)

exten => s-FIXED,1,NoOp(Device is FIXED and cannot be logged out of)
exten => s-FIXED,2,Playback(an-error-has-occured)
exten => s-FIXED,3,Playback(vm-goodbye)
exten => s-FIXED,4,Hangup ;TODO should play msg indicated device cannot be logged into

[macro-systemrecording]
exten => s,1,Goto(${ARG1},1)

exten => dorecord,1,Record(/tmp/${AMPUSER}-ivrrecording:wav)
exten => dorecord,n,Wait(1)
exten => dorecord,n,Goto(confmenu,1)

exten => docheck,1,Playback(/tmp/${AMPUSER}-ivrrecording)
exten => docheck,n,Wait(1)
exten => docheck,n,Goto(confmenu,1)

exten => confmenu,1,Background(to-listen-to-it&press-1&to-rerecord-it&press-star,m,${LANGUAGE},macro-systemrecording)
exten => confmenu,n,Read(RECRESULT,1,4)
exten => confmenu,n,GotoIf($[“x${RECRESULT}”=“x*”]?dorecord,1)
exten => confmenu,n,GotoIf($[“x${RECRESULT}”=“x1”]?docheck,1)
exten => confmenu,n,Goto(1)

exten => 1,1,Goto(docheck,1)
exten => *,1,Goto(dorecord,1)

exten => t,1,Playback(goodbye)
exten => t,n,Hangup

exten => i,1,Playback(pm-invalid-option)
exten => i,n,Goto(confmenu,1)

exten => h,1,Hangup

;
; ############################################################################
; CallerID Handling
; ############################################################################

;sets the callerid of the device to that of the logged in user
;
; ${AMPUSER} is set upon return to the real user despite any aliasing that may
; have been set as a result of the AMPUSER//cidnum field. This is used by
; features like DND, CF, etc. to set the proper structure on aliased instructions
;
[macro-user-callerid]
exten => s,1,Noop(user-callerid: ${CALLERID(name)} ${CALLERID(number)})

; make sure AMPUSER is set if it doesn’t get set below
;
exten => s,n,Set(AMPUSER=${IF($[“foo${AMPUSER}” = “foo”]?${CALLERID(number)}:${AMPUSER})})
exten => s,n,GotoIf($["${CHANNEL:0:5}" = “Local”]?report)
exten => s,n,GotoIf($["${REALCALLERIDNUM:1:2}" != “”]?start)
exten => s,n,Set(REALCALLERIDNUM=${CALLERID(number)})
exten => s,n(start),NoOp(REALCALLERIDNUM is ${REALCALLERIDNUM})
exten => s,n,Set(AMPUSER=${DB(DEVICE/${REALCALLERIDNUM}/user)})
exten => s,n,Set(AMPUSERCIDNAME=${DB(AMPUSER/${AMPUSER}/cidname)})
exten => s,n,GotoIf($[“x${AMPUSERCIDNAME:1:2}” = “x”]?report)

; user may masquerade as a different user internally, so set the internal cid as indicated
; but keep the REALCALLERID which is used to determine their true identify and lookup info
; during outbound calls.
;
exten => s,n,Set(AMPUSERCID=${IF($["${DB_EXISTS(AMPUSER/${AMPUSER}/cidnum)}" = “1”]?${DB_RESULT}:${AMPUSER})})
exten => s,n,Set(CALLERID(all)="${AMPUSERCIDNAME}" <${AMPUSERCID}>)
exten => s,n,Set(REALCALLERIDNUM=${DB(DEVICE/${REALCALLERIDNUM}/user)})
exten => s,n(report),Noop(TTL: ${TTL} ARG1: ${ARG1})
exten => s,n,GotoIf($[ “${ARG1}” = “SKIPTTL” ]?continue)
exten => s,n(report2),Set(__TTL=${IF($[“foo${TTL}” = “foo”]?64:$[ ${TTL} - 1 ])})
exten => s,n,GotoIf($[ ${TTL} > 0 ]?continue)
exten => s,n,Wait(${RINGTIMER}) ; wait for a while, to give it a chance to be picked up by voicemail
exten => s,n,Answer()
exten => s,n,Wait(2)
exten => s,n,Playback(im-sorry&an-error-has-occured&with&call-forwarding)
exten => s,n,Macro(hangupcall)
exten => s,n,Congestion()
exten => s,n(continue),NoOp(Using CallerID ${CALLERID(all)})
exten => h,1,Macro(hangupcall)

; overrides callerid out trunks
; arg1 is trunk
; macro-user-callerid should be called before using this macro
[macro-outbound-callerid]
; Keep the original CallerID number, for failover to the next trunk.
exten => s,1,GotoIf($["${REALCALLERIDNUM:1:2}" != “”]?start)
exten => s,n,Set(REALCALLERIDNUM=${CALLERID(number)})
exten => s,n(start),NoOp(REALCALLERIDNUM is ${REALCALLERIDNUM})

; If this came through a ringgroup or CF, then we want to retain original CID unless
; OUTKEEPCID_${trunknum} is set.
;
exten => s,n,GotoIf($["${KEEPCID}" != “TRUE”]?normcid) ;Set to TRUE if coming from ringgroups, CF, etc.
exten => s,n,GotoIf($[“x${OUTKEEPCID_${ARG1}}” = “xon”]?normcid)
exten => s,n,GotoIf($[“foo${REALCALLERIDNUM}” = “foo”]?normcid) ;if not set to anything, go through normal processing
exten => s,n,Set(USEROUTCID=${REALCALLERIDNUM})

; We now have to make sure the CID is valid. If we find an AMPUSER with the same CID, we assume it is an internal
; call (would be quite a conincidence if not) and go through the normal processing to get that CID. If a device
; is set for this CID, then it must be internal
;
exten => s,n,GotoIf($[“foo${DB(AMPUSER/${REALCALLERIDNUM}/device)}” = “foo”]?bypass:normcid)

exten => s,n(normcid),Set(USEROUTCID=${DB(AMPUSER/${REALCALLERIDNUM}/outboundcid)})
exten => s,n(bypass),Set(EMERGENCYCID=${DB(DEVICE/${REALCALLERIDNUM}/emergency_cid)})
exten => s,n,Set(TRUNKOUTCID=${OUTCID_${ARG1}})
exten => s,n,GotoIf($["${EMERGENCYROUTE:1:2}" = “”]?trunkcid) ; check EMERGENCY ROUTE
exten => s,n,GotoIf($["${EMERGENCYCID:1:2}" = “”]?trunkcid) ; empty EMERGENCY CID, so default back to trunk
exten => s,n,Set(CALLERID(all)=${EMERGENCYCID}) ; emergency cid for device
exten => s,n,Goto(report)
exten => s,n(trunkcid),GotoIf($["${TRUNKOUTCID:1:2}" = “”]?usercid) ;check for CID override for trunk (global var)
exten => s,n,Set(CALLERID(all)=${TRUNKOUTCID})
exten => s,n(usercid),GotoIf($["${USEROUTCID:1:2}" = “”]?report) ; check CID override for extension
exten => s,n,Set(CALLERID(all)=${USEROUTCID})
exten => s,n,GotoIf($[“x${CALLERID(name)}”!=“xhidden”]?report:hidecid) ; check CID blocking for extension
exten => s,n(hidecid),SetCallerPres(prohib_passed_screen) ; Only works with ISDN (T1/E1/BRI)
exten => s,n(report),NoOp(CallerID set to ${CALLERID(all)})

; Privacy Manager Macro makes sure that any calls that don’t pass the privacy manager are presented
; with congestion since there have been observed cases of the call continuing if not stopped with a
; congestion, and this provides a slightly more friendly ‘sorry’ message in case the user is
; legitamately trying to be cooperative.
;
; Note: the following options are configurable in privacy.conf:
;
; maxretries = 3 ; default value, number of retries before failing
; minlength = 10 ; default value, number of digits to be accepted as valid CID
;
[macro-privacy-mgr]
exten => s,1,Set(KEEPCID=${CALLERID(num)})
exten => s,n,GotoIf($[“foo${CALLERID(num):0:1}”=“foo+”]?CIDTEST2:CIDTEST1)
exten => s,n(CIDTEST1),Set(TESTCID=${MATH(1+${CALLERID(num)})})
exten => s,n,Goto(TESTRESULT)
exten => s,n(CIDTEST2),Set(TESTCID=${MATH(1+${CALLERID(num):1})})
exten => s,n(TESTRESULT),GotoIf($[“foo${TESTCID}”=“foo”]?CLEARCID:PRIVMGR)
exten => s,n(CLEARCID),Set(CALLERID(num)=)
exten => s,n(PRIVMGR),PrivacyManager()
exten => s,n,GotoIf($["${PRIVACYMGRSTATUS}"=“FAILED”]?fail)
exten => s,n,SetCallerPres(allowed_passed_screen); stop gap until app_privacy.c clears unavailble bit
exten => s,PRIVMGR+101(fail),Noop(STATUS: ${PRIVACYMGRSTATUS} CID: ${CALLERID(num)} ${CALLERID(name)} CALLPRES: ${CALLLINGPRES})
exten => s,n,Playback(sorry-youre-having-problems)
exten => s,n,Playback(goodbye)
exten => s,n,Playtones(congestion)
exten => s,n,Congestion(5)

; Text-To-Speech related macros
; These all follow common actions. First try to playback a file “tts/custom-md5”
; where “md5” is the md5() of whatever is going to be played. If that doesn’t exist,
; try to playback using macro-tts-sayXXXXX (where XXXXX is text/digits/etc, same as
; the macro below). If that macro exits with MACRO_OFFSET=100, then it’s done,
; therwise, fallback to the default asterisk method.
;
; say text is purely for text-to-speech, there is no fallback
[macro-saytext]
exten => s,1,Noop(Trying custom SayText playback for “${ARG1}”)
exten => s,n,Playback(tts/custom-${MD5(${ARG1})})
exten => s,n,GotoIf($["${PLAYBACKSTATUS}"=“SUCCESS”]?done)
; call tts-saytext. This should set MACRO_OFFSET=101 if it was successful
exten => s,n(tts),Macro(tts-saytext,${ARG1},${ARG2},${ARG3})
exten => s,n,Noop(No text-to-speech handler for SayText, cannot say “${ARG1}”)
exten => s,n,Goto(done)
exten => s,tts+101,Noop(tts handled saytext)

; say name is for saying names typically, but fallsback to using SayAlpha
; (saying the word letter-by-letter)
[macro-sayname]
exten => s,1,Noop(Trying custom SayName playback for “${ARG1}”)
exten => s,n,Playback(tts/custom-${MD5(${ARG1})})
exten => s,n,GotoIf($["${PLAYBACKSTATUS}"=“SUCCESS”]?done)
; call tts-sayalpha. This should set MACRO_OFFSET=101 if it was successful
exten => s,n(tts),Macro(tts-sayalpha,${ARG1},${ARG2},${ARG3})
exten => s,n,SayAlpha(${ARG1})
exten => s,n,Goto(done)
exten => s,tts+101,Noop(tts handled sayname)

; Say number is for saying numbers (eg “one thousand forty six”)
[macro-saynumber]
exten => s,1,Noop(Trying custom SayNumber playback for “${ARG1}”)
exten => s,n,Playback(tts/custom-${MD5(${ARG1})})
exten => s,n,GotoIf($["${PLAYBACKSTATUS}"=“SUCCESS”]?done)
; call tts-saynumber. This should set MACRO_OFFSET=101 if it was successful
exten => s,n(tts),Macro(tts-saynumber,${ARG1},${ARG2},${ARG3})
exten => s,n,SayNumber(${ARG1})
exten => s,n,Goto(done)
exten => s,tts+101,Noop(tts handled saynumber)

; Say digits is for saying digits one-by-one (eg, “one zero four six”)
[macro-saydigits]
exten => s,1,Noop(Trying custom SayDigits playback for “${ARG1}”)
exten => s,n,Playback(tts/custom-${MD5(${ARG1})})
exten => s,n,GotoIf($["${PLAYBACKSTATUS}"=“SUCCESS”]?done)
; call tts-saydigits. This should set MACRO_OFFSET=101 if it was successful
exten => s,n(tts),Macro(tts-saydigits,${ARG1},${ARG2},${ARG3})
exten => s,n,SayDigits(${ARG1})
exten => s,n,Goto(done)

;
; ############################################################################
; Inbound Contexts [from]
; ############################################################################

[from-sip-external]
;give external sip users congestion and hangup
; Yes. This is really meant to be _. - I know asterisk whinges about it, but
; I do know what I’m doing. This is correct.
exten => _.,1,NoOp(Received incoming SIP connection from unknown peer to ${EXTEN})
exten => _.,n,Set(DID=${IF($["${EXTEN:1:2}"=""]?s:${EXTEN})})
exten => _.,n,Goto(s,1)
exten => s,1,GotoIf($["${ALLOW_SIP_ANON}"=“yes”]?from-trunk,${DID},1)
exten => s,n,Set(TIMEOUT(absolute)=15)
exten => s,n,Answer
exten => s,n,Wait(2)
exten => s,n,Playback(ss-noservice)
exten => s,n,Playtones(congestion)
exten => s,n,Congestion(5)
exten => h,1,NoOp(Hangup)
exten => i,1,NoOp(Invalid)
exten => t,1,NoOp(Timeout)

[from-internal-xfer]
; applications are now mostly all found in from-internal-additional in _custom.conf
include => parkedcalls
include => from-internal-custom
;allow phones to dial other extensions
include => ext-fax
;allow phones to access generated contexts
;
; MODIFIED (PL)
;
; Currently the include for findmefollow is being auto-generated before ext-local which is the desired behavior.
; However, I haven’t been able to do anything that I know of to force this. We need to determine if it should
; be hardcoded into here to make sure it doesn’t change with some configuration. For now I will leave it out
; until we can discuss this.
;
include => ext-local-confirm
include => findmefollow-ringallv2
include => from-internal-additional
; This causes grief with ‘#’ transfers, commenting out for the moment.
; include => bad-number
exten => s,1,Macro(hangupcall)
exten => h,1,Macro(hangupcall)

[from-internal]
include => from-internal-xfer
include => bad-number

[from-zaptel]
exten => _X.,1,Set(DID=${EXTEN})
exten => _X.,n,Goto(s,1)
exten => s,1,NoOp(Entering from-zaptel with DID == ${DID})
; Some trunks require a RINGING be sent before an Answer.
exten => s,n,Ringing()
; If ($did == “”) { $did = “s”; }
exten => s,n,Set(DID=${IF($["${DID}"= “”]?s:${DID})})
exten => s,n,NoOp(DID is now ${DID})
exten => s,n,GotoIf($["${CHANNEL:0:3}"=“Zap”]?zapok:notzap)
exten => s,n(notzap),Goto(from-pstn,${DID},1)
; If there’s no ext-did,s,1, that means there’s not a no did/no cid route. Hangup.
exten => s,n,Macro(hangup)
exten => s,n(zapok),NoOp(Is a Zaptel Channel)
exten => s,n,Set(CHAN=${CHANNEL:4})
exten => s,n,Set(CHAN=${CUT(CHAN,-,1)})
exten => s,n,Macro(from-zaptel-${CHAN},${DID},1)
; If nothing there, then treat it as a DID
exten => s,n,NoOp(Returned from Macro from-zaptel-${CHAN})
exten => s,n,Goto(from-pstn,${DID},1)
exten => fax,1,Goto(ext-fax,in_fax,1)

;------------------------------------------------------------------------
; [macro-setmusic]
;------------------------------------------------------------------------
; CONTEXT: macro-setmusic
; PURPOSE: to turn off moh on routes where it is not desired
;
;------------------------------------------------------------------------
[macro-setmusic]
exten => s,1,NoOp(Setting Outbound Route MoH To: ${ARG1})
exten => s,2,SetMusicOnHold(${ARG1})
;------------------------------------------------------------------------

; ##########################################
; ## Ring Groups with Confirmation macros ##
; ##########################################
; Used by followme and ringgroups

;------------------------------------------------------------------------
; [macro-dial-confirm]
;------------------------------------------------------------------------
; This has now been incorporated into dialparties. It still only works with ringall
; and ringall-prim strategies. Have not investigated why it doesn’t work with
; hunt and memory hunt.
;
;------------------------------------------------------------------------
[macro-dial-confirm]
; This was written to make it easy to use macro-dial-confirm instead of macro-dial in generated dialplans.
; This takes the same paramaters, with an additional paramater of the ring group Number
; ARG1 is the timeout
; ARG2 is the DIAL_OPTIONS
; ARG3 is a list of xtns to call - 203-222-240-123123123#-211
; ARG4 is the ring group number

; This sets a unique value to indicate that the channel is ringing. This is used for warning slow
; users that the call has already been picked up.
;
exten => s,1,Set(DB(RG/${ARG4}/${CHANNEL})=RINGING)

; We need to keep that channel variable, because it’ll change when we do this dial, so set it to
; fallthrough to every sibling.
;
exten => s,n,Set(__UNIQCHAN=${CHANNEL})

; The calling ringgroup should have set RingGroupMethod appropriately. We need to set two
; additional parameters:
;
; USE_CONFIRMATION, RINGGROUP_INDEX
;
; Thse are passed to inform dialparties to place external calls through the [grps] context
;
exten => s,n,Set(USE_CONFIRMATION=TRUE)
exten => s,n,Set(RINGGROUP_INDEX=${ARG4})
exten => s,n,Set(ARG4=) ; otherwise it gets passed to dialparties.agi which processes it (prob bug)

exten => s,n,Macro(dial,${ARG1},${ARG2},${ARG3})

; delete the variable, if we are here, we are done trying to dial and it may have been left around
;
exten => s,n,DBDel(RG/${RINGGROUP_INDEX}/${CHANNEL})
exten => s,n,Set(USE_CONFIRMATION=)
exten => s,n,Set(RINGGROUP_INDEX=)
;------------------------------------------------------------------------

;------------------------------------------------------------------------
; [macro-auto-confirm]
;------------------------------------------------------------------------
; This macro is called from ext-local-confirm to auto-confirm a call so that other extensions
; are aware that the call has been answered.
;
;------------------------------------------------------------------------
[macro-auto-confirm]
exten => s,1,Set(__MACRO_RESULT=)
exten => s,n,DBDel(${BLKVM_OVERRIDE})
exten => s,n,DBDel(RG/${ARG1}/${UNIQCHAN})

;------------------------------------------------------------------------
; [macro-auto-blkvm]
;------------------------------------------------------------------------
; This macro is called for any extension dialed form a queue, ringgroup
; or followme, so that the answering extension can clear the voicemail block
; override allow subsequent transfers to properly operate.
;
;------------------------------------------------------------------------
[macro-auto-blkvm]
exten => s,1,Set(__MACRO_RESULT=)
exten => s,n,DBDel(${BLKVM_OVERRIDE})

;------------------------------------------------------------------------
; [ext-local-confirm]
;------------------------------------------------------------------------
; If call confirm is being used in a ringgroup, then calls that do not require confirmation are sent
; to this extension instead of straight to the device.
;
; The sole purpose of sending them here is to make sure we run Mac

also heres the last 2000 lines from debug log

FreePBX
FreePBX 2.3.0.3 on asterisk

* Admin
* Reports
* Panel
* Recordings
* Help
*  

FreePBX
Logged in: admin (Logout)

* Setup
* Tools
  • Admin

  • FreePBX System Status

  • Module Admin

  • Basic

  • Administrators

  • Extensions

  • Feature Codes

  • General Settings

  • Outbound Routes

  • Trunks

  • Inbound Call Control

  • Inbound Routes

  • IVR

  • Ring Groups

  • Time Conditions

  • Internal Options & Configuration

  • Conferences

  • Misc Applications

  • Misc Destinations

  • Music on Hold

  • System Recordings

  • Admin

  • FreePBX System Status

  • Module Admin

  • Support

  • Asterisk Logfiles

  • FreePBX Support

  • System Administration

  • Asterisk CLI

/var/log/asterisk/full - last 2000 lines
Redisplay Asterisk Full debug log (last 2000 lines)

Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 13 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 14 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 15 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 16 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 17 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 18 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 19 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 20 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 21 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 22 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 23 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 24 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 25 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 26 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 27 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 29 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 30 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 31 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 32 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 33 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 34 to macro-dumpvars
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-user-logon’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 7 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 8 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 9 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 10 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 11 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 12 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 13 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 14 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 15 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 16 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 17 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 18 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 19 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 20 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 21 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-FIXED’ priority 1 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-FIXED’ priority 2 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-FIXED’ priority 3 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-FIXED’ priority 4 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-FIXED’ priority 5 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-FIXED’ priority 6 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-ALREADYLOGGEDON’ priority 1 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-ALREADYLOGGEDON’ priority 2 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-ALREADYLOGGEDON’ priority 3 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-NOPASSWORD’ priority 1 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-NOPASSWORD’ priority 2 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-NOPASSWORD’ priority 3 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-NOPASSWORD’ priority 4 to macro-user-logon
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-user-logoff’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 7 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 8 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 9 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-FIXED’ priority 1 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-FIXED’ priority 2 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-FIXED’ priority 3 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s-FIXED’ priority 4 to macro-user-logoff
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-systemrecording’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘dorecord’ priority 1 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘dorecord’ priority 2 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘dorecord’ priority 3 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘docheck’ priority 1 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘docheck’ priority 2 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘docheck’ priority 3 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘confmenu’ priority 1 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘confmenu’ priority 2 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘confmenu’ priority 3 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘confmenu’ priority 4 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘confmenu’ priority 5 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘1’ priority 1 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘*’ priority 1 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘t’ priority 1 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘t’ priority 2 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘i’ priority 1 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘i’ priority 2 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘h’ priority 1 to macro-systemrecording
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-user-callerid’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 7 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 8 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 9 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 10 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 11 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 12 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 13 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 14 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 15 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 16 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 17 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 18 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 19 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 20 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 21 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 22 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 23 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘h’ priority 1 to macro-user-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-outbound-callerid’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 7 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 8 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 9 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 10 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 11 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 12 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 13 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 14 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 15 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 16 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 17 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 18 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 19 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 20 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 21 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 22 to macro-outbound-callerid
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-privacy-mgr’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 7 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 8 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 9 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 10 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 109 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 110 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 111 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 112 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 113 to macro-privacy-mgr
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-saytext’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-saytext
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-saytext
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to macro-saytext
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to macro-saytext
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to macro-saytext
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to macro-saytext
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 105 to macro-saytext
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-sayname’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-sayname
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-sayname
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to macro-sayname
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to macro-sayname
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to macro-sayname
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to macro-sayname
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 105 to macro-sayname
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-saynumber’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-saynumber
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-saynumber
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to macro-saynumber
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to macro-saynumber
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to macro-saynumber
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to macro-saynumber
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 105 to macro-saynumber
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-saydigits’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-saydigits
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-saydigits
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to macro-saydigits
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to macro-saydigits
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to macro-saydigits
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to macro-saydigits
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'from-sip-external’
Jun 18 13:58:08 WARNING[6081] pbx_config.c: The use of ‘.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 1112
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension '
.’ priority 1 to from-sip-external
Jun 18 13:58:08 WARNING[6081] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 1113
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension '
.’ priority 2 to from-sip-external
Jun 18 13:58:08 WARNING[6081] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 1114
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension '
.’ priority 3 to from-sip-external
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to from-sip-external
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to from-sip-external
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to from-sip-external
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to from-sip-external
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to from-sip-external
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to from-sip-external
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 7 to from-sip-external
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘h’ priority 1 to from-sip-external
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘i’ priority 1 to from-sip-external
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘t’ priority 1 to from-sip-external
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'from-internal-xfer’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Including context ‘parkedcalls’ in context 'from-internal-xfer’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Including context ‘from-internal-custom’ in context 'from-internal-xfer’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Including context ‘ext-fax’ in context 'from-internal-xfer’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Including context ‘ext-local-confirm’ in context 'from-internal-xfer’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Including context ‘findmefollow-ringallv2’ in context 'from-internal-xfer’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Including context ‘from-internal-additional’ in context 'from-internal-xfer’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to from-internal-xfer
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘h’ priority 1 to from-internal-xfer
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'from-internal’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Including context ‘from-internal-xfer’ in context 'from-internal’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Including context ‘bad-number’ in context 'from-internal’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'from-zaptel’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_X.’ priority 1 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_X.’ priority 2 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 7 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 8 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 9 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 10 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 11 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 12 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 13 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘fax’ priority 1 to from-zaptel
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-setmusic’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-setmusic
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-setmusic
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-dial-confirm’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-dial-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-dial-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to macro-dial-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to macro-dial-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to macro-dial-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to macro-dial-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 7 to macro-dial-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 8 to macro-dial-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 9 to macro-dial-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-auto-confirm’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-auto-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-auto-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to macro-auto-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-auto-blkvm’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-auto-blkvm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-auto-blkvm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'ext-local-confirm’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_LC-.’ priority 1 to ext-local-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_LC-.’ priority 2 to ext-local-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_LC-.’ priority 3 to ext-local-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_LC-.’ priority 4 to ext-local-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'macro-confirm’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 3 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 4 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 5 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 6 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 7 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 8 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 9 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 10 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 11 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 12 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 13 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 14 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 15 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 16 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 17 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 18 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 19 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 20 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 21 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 22 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 23 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 24 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘h’ priority 1 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘h’ priority 2 to macro-confirm
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'findmefollow-ringallv2’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMPR-.’ priority 1 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMPR-.’ priority 2 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMPR-.’ priority 3 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMPR-.’ priority 4 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMPR-.’ priority 5 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMPR-.’ priority 6 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMPR-.’ priority 7 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMPR-.’ priority 8 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMPR-.’ priority 9 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 1 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 2 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 3 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 4 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 5 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 6 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 7 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 8 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 9 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 10 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 11 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 12 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 23 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 24 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 25 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘_FMGL-.’ priority 26 to findmefollow-ringallv2
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Registered extension context 'ext-fax’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 1 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘s’ priority 2 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘in_fax’ priority 1 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘in_fax’ priority 2 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘in_fax’ priority 3 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘in_fax’ priority 4 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘analog_fax’ priority 1 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘analog_fax’ priority 2 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘analog_fax’ priority 3 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘analog_fax’ priority 4 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘out_fax’ priority 1 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘out_fax’ priority 2 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘h’ priority 1 to ext-fax
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Added extension ‘h’ priority 2 to ext-fax
Jun 18 13:58:08 WARNING[6081] pbx.c: Tried to register context ‘default’, already in use
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘from-did-direct’ tries includes nonexistent context 'ext-findmefollow’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘from-pstn’ tries includes nonexistent context 'from-pstn-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘from-internal-additional’ tries includes nonexistent context 'from-internal-additional-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘from-internal-additional’ tries includes nonexistent context 'grps’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘bad-number’ tries includes nonexistent context 'bad-number-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-blackhole’ tries includes nonexistent context 'app-blackhole-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘outrt-001-OutgoingTrunk’ tries includes nonexistent context 'outrt-001-OutgoingTrunk-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘outbound-allroutes’ tries includes nonexistent context 'outbound-allroutes-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-local’ tries includes nonexistent context 'ext-local-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-did-catchall’ tries includes nonexistent context 'ext-did-catchall-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-did’ tries includes nonexistent context 'ext-did-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-test’ tries includes nonexistent context 'ext-test-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-chanspy’ tries includes nonexistent context 'app-chanspy-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-zapbarge’ tries includes nonexistent context 'app-zapbarge-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-pickup’ tries includes nonexistent context 'app-pickup-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-userlogonoff’ tries includes nonexistent context 'app-userlogonoff-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-group’ tries includes nonexistent context 'ext-group-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-pbdirectory’ tries includes nonexistent context 'app-pbdirectory-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-miscapps-1’ tries includes nonexistent context 'app-miscapps-1-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-miscdests’ tries includes nonexistent context 'ext-miscdests-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ivr-4’ tries includes nonexistent context 'ivr-4-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ivr-4’ tries includes nonexistent context 'ext-findmefollow’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-meetme’ tries includes nonexistent context 'ext-meetme-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-unavailable-on’ tries includes nonexistent context 'app-cf-unavailable-on-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-unavailable-off’ tries includes nonexistent context 'app-cf-unavailable-off-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-on’ tries includes nonexistent context 'app-cf-on-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-off-any’ tries includes nonexistent context 'app-cf-off-any-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-off’ tries includes nonexistent context 'app-cf-off-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-busy-on’ tries includes nonexistent context 'app-cf-busy-on-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-busy-off-any’ tries includes nonexistent context 'app-cf-busy-off-any-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-busy-off’ tries includes nonexistent context 'app-cf-busy-off-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-vmmain’ tries includes nonexistent context 'app-vmmain-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-dialvm’ tries includes nonexistent context 'app-dialvm-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-speakingclock’ tries includes nonexistent context 'app-speakingclock-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-speakextennum’ tries includes nonexistent context 'app-speakextennum-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-echo-test’ tries includes nonexistent context 'app-echo-test-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-directory’ tries includes nonexistent context 'app-directory-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-calltrace-perform’ tries includes nonexistent context 'app-calltrace-perform-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-calltrace’ tries includes nonexistent context 'app-calltrace-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-recordings’ tries includes nonexistent context 'ext-recordings-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-recordings’ tries includes nonexistent context 'app-recordings-custom’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Reloading module ‘pbx_dundi.so’ (Distributed Universal Number Discovery (DUNDi))
Jun 18 13:58:08 ERROR[6081] pbx_dundi.c: Unable to load config dundi.conf
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Reloading module ‘pbx_ael.so’ (Asterisk Extension Language Compiler)
Jun 18 13:58:08 WARNING[6081] pbx_ael.c: Unable to open ‘/etc/asterisk/extensions.ael’: No such file or directory
Jun 18 13:58:08 WARNING[6081] pbx.c: Requested contexts didn’t get merged
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘from-did-direct’ tries includes nonexistent context 'ext-findmefollow’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘from-pstn’ tries includes nonexistent context 'from-pstn-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘from-internal-additional’ tries includes nonexistent context 'from-internal-additional-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘from-internal-additional’ tries includes nonexistent context 'grps’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘bad-number’ tries includes nonexistent context 'bad-number-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-blackhole’ tries includes nonexistent context 'app-blackhole-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘outrt-001-OutgoingTrunk’ tries includes nonexistent context 'outrt-001-OutgoingTrunk-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘outbound-allroutes’ tries includes nonexistent context 'outbound-allroutes-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-local’ tries includes nonexistent context 'ext-local-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-did-catchall’ tries includes nonexistent context 'ext-did-catchall-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-did’ tries includes nonexistent context 'ext-did-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-test’ tries includes nonexistent context 'ext-test-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-chanspy’ tries includes nonexistent context 'app-chanspy-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-zapbarge’ tries includes nonexistent context 'app-zapbarge-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-pickup’ tries includes nonexistent context 'app-pickup-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-userlogonoff’ tries includes nonexistent context 'app-userlogonoff-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-group’ tries includes nonexistent context 'ext-group-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-pbdirectory’ tries includes nonexistent context 'app-pbdirectory-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-miscapps-1’ tries includes nonexistent context 'app-miscapps-1-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-miscdests’ tries includes nonexistent context 'ext-miscdests-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ivr-4’ tries includes nonexistent context 'ivr-4-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ivr-4’ tries includes nonexistent context 'ext-findmefollow’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-meetme’ tries includes nonexistent context 'ext-meetme-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-unavailable-on’ tries includes nonexistent context 'app-cf-unavailable-on-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-unavailable-off’ tries includes nonexistent context 'app-cf-unavailable-off-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-on’ tries includes nonexistent context 'app-cf-on-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-off-any’ tries includes nonexistent context 'app-cf-off-any-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-off’ tries includes nonexistent context 'app-cf-off-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-busy-on’ tries includes nonexistent context 'app-cf-busy-on-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-busy-off-any’ tries includes nonexistent context 'app-cf-busy-off-any-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-cf-busy-off’ tries includes nonexistent context 'app-cf-busy-off-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-vmmain’ tries includes nonexistent context 'app-vmmain-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-dialvm’ tries includes nonexistent context 'app-dialvm-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-speakingclock’ tries includes nonexistent context 'app-speakingclock-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-speakextennum’ tries includes nonexistent context 'app-speakextennum-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-echo-test’ tries includes nonexistent context 'app-echo-test-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-directory’ tries includes nonexistent context 'app-directory-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-calltrace-perform’ tries includes nonexistent context 'app-calltrace-perform-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-calltrace’ tries includes nonexistent context 'app-calltrace-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘ext-recordings’ tries includes nonexistent context 'ext-recordings-custom’
Jun 18 13:58:08 WARNING[6081] pbx.c: Context ‘app-recordings’ tries includes nonexistent context 'app-recordings-custom’
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Reloading module ‘chan_sip.so’ (Session Initiation Protocol (SIP))
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reloading SIP
Jun 18 13:58:08 VERBOSE[4030] logger.c: == Parsing ‘/etc/asterisk/sip.conf’: Jun 18 13:58:08 VERBOSE[4030] logger.c: == Parsing ‘/etc/asterisk/sip.conf’: Found
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Reloading module ‘chan_agent.so’ (Agent Proxy Channel)
Jun 18 13:58:08 NOTICE[6081] chan_agent.c: No agent configuration found – agent support disabled
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Reloading module ‘chan_mgcp.so’ (Media Gateway Control Protocol (MGCP))
Jun 18 13:58:08 VERBOSE[4031] logger.c: Reloading MGCP
Jun 18 13:58:08 NOTICE[4031] chan_mgcp.c: Unable to load config mgcp.conf, MGCP disabled
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Reloading module ‘chan_iax2.so’ (Inter Asterisk eXchange (Ver 2))
Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/iax.conf’: Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/iax.conf’: Found
Jun 18 13:58:08 VERBOSE[4030] logger.c: == Parsing ‘/etc/asterisk/sip_general_custom.conf’: Jun 18 13:58:08 VERBOSE[4030] logger.c: == Parsing ‘/etc/asterisk/sip_general_custom.conf’: Found
Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/iax_registrations.conf’: Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/iax_registrations.conf’: Found
Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/iax_additional.conf’: Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/iax_additional.conf’: Found
Jun 18 13:58:08 NOTICE[6081] chan_iax2.c: Ignoring bindport on reload
Jun 18 13:58:08 NOTICE[6081] chan_iax2.c: Ignoring bindaddr on reload
Jun 18 13:58:08 VERBOSE[4030] logger.c: == Parsing ‘/etc/asterisk/sip_nat.conf’: Jun 18 13:58:08 VERBOSE[4030] logger.c: == Parsing ‘/etc/asterisk/sip_nat.conf’: Found
Jun 18 13:58:08 VERBOSE[4030] logger.c: == Parsing ‘/etc/asterisk/sip_registrations.conf’: Jun 18 13:58:08 VERBOSE[4030] logger.c: == Parsing ‘/etc/asterisk/sip_registrations.conf’: Found
Jun 18 13:58:08 VERBOSE[4030] logger.c: == Parsing ‘/etc/asterisk/sip_additional.conf’: Jun 18 13:58:08 VERBOSE[4030] logger.c: == Parsing ‘/etc/asterisk/sip_additional.conf’: Found
Jun 18 13:58:08 DEBUG[4030] acl.c: 10.10.5.0/255.255.255.0/255.255.255.0 appended to acl for peer
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot disallow unknown format ''
Jun 18 13:58:08 WARNING[4030] frame.c: Cannot allow unknown format ''
Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 64.47.33.25 with 10.10.5.0
Jun 18 13:58:08 DEBUG[4030] chan_sip.c: Target address 64.47.33.25 is not local, substituting externip
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 64.47.33.25:5060:
OPTIONS sip:64.47.33.25 SIP/2.0
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK4b043506;rport
From: “Unknown” ;tag=as5c2bc655
To:
Contact:
Call-ID: 50f74d5a12b22936007bfa0832df62a8@38.119.187.34
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Wed, 18 Jun 2008 18:58:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 64.47.33.25 with 10.10.5.0
Jun 18 13:58:08 DEBUG[4030] chan_sip.c: Target address 64.47.33.25 is not local, substituting externip
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 64.47.33.25:5060:
OPTIONS sip:64.47.33.25 SIP/2.0
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK23514714;rport
From: “Unknown” ;tag=as0ac9a793
To:
Contact:
Call-ID: 5d6367e1029928e436cd874d56cc4767@38.119.187.34
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Wed, 18 Jun 2008 18:58:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 10.10.5.213 with 10.10.5.0
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 10.10.5.213:5061:
OPTIONS sip:108@10.10.5.213:5061 SIP/2.0
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK677eefb7;rport
From: “Unknown” ;tag=as15552d49
To:
Contact:
Call-ID: 2fcc3ee1293f86636d2b350a26c5f0ed@10.10.5.10
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Wed, 18 Jun 2008 18:58:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 10.10.5.246 with 10.10.5.0
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 10.10.5.246:5060:
OPTIONS sip:107@10.10.5.246:5060 SIP/2.0
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK35c5a0be;rport
From: “Unknown” ;tag=as5b57e223
To:
Contact:
Call-ID: 5afd004e44701c00351a43664da073d7@10.10.5.10
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Wed, 18 Jun 2008 18:58:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 10.10.5.248 with 10.10.5.0
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 10.10.5.248:5060:
OPTIONS sip:106@10.10.5.248:5060 SIP/2.0
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK713cc8d1;rport
From: “Unknown” ;tag=as1418e5df
To:
Contact:
Call-ID: 62f39fad1cbed0ad62b203500aa6598b@10.10.5.10
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Wed, 18 Jun 2008 18:58:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 10.10.5.196 with 10.10.5.0
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 10.10.5.196:5060:
OPTIONS sip:105@10.10.5.196:5060 SIP/2.0
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK54290c52;rport
From: “Unknown” ;tag=as7c2a5807
To:
Contact:
Call-ID: 16234eb257d5c3833ab3e33a16dfa98f@10.10.5.10
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Wed, 18 Jun 2008 18:58:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 10.10.5.245 with 10.10.5.0
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 10.10.5.245:5060:
OPTIONS sip:104@10.10.5.245:5060 SIP/2.0
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK06f7936b;rport
From: “Unknown” ;tag=as0e23d6c3
To:
Contact:
Call-ID: 6dee053517c82fe6271e83d731e82b6a@10.10.5.10
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Wed, 18 Jun 2008 18:58:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 10.10.5.247 with 10.10.5.0
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 10.10.5.247:5060:
OPTIONS sip:103@10.10.5.247:5060 SIP/2.0
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK3eec21c4;rport
From: “Unknown” ;tag=as3232e0b7
To:
Contact:
Call-ID: 5b905b370797701c49c237725f1764bb@10.10.5.10
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Wed, 18 Jun 2008 18:58:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 10.10.5.179 with 10.10.5.0
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 10.10.5.179:5061:
OPTIONS sip:102@10.10.5.179:5061 SIP/2.0
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK1d11e1fc;rport
From: “Unknown” ;tag=as4454d98d
To:
Contact:
Call-ID: 26c63fdc4c1a68be243647297f8e294d@10.10.5.10
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Wed, 18 Jun 2008 18:58:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 10.10.5.179 with 10.10.5.0
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 10.10.5.179:5060:
OPTIONS sip:101@10.10.5.179:5060 SIP/2.0
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK17e87b7c;rport
From: “Unknown” ;tag=as52d6d39a
To:
Contact:
Call-ID: 6b52a462593123370ee79a8623008065@10.10.5.10
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Wed, 18 Jun 2008 18:58:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 10.10.5.213 with 10.10.5.0
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 10.10.5.213:5061:
OPTIONS sip:100@10.10.5.213:5061 SIP/2.0
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK273d793a;rport
From: “Unknown” ;tag=as3ef02d81
To:
Contact:
Call-ID: 4c30358e10baf52d27d869c72402c1ce@10.10.5.10
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Wed, 18 Jun 2008 18:58:08 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 18 13:58:08 VERBOSE[4030] logger.c:
<-- SIP read from 10.10.5.246:5060:
SIP/2.0 200 OK
To: ;tag=caf29192bfcb22c4i0
From: “Unknown” ;tag=as5b57e223
Call-ID: 5afd004e44701c00351a43664da073d7@10.10.5.10
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK35c5a0be
Server: Sipura/SPA921-4.1.10(b)
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER

Jun 18 13:58:08 VERBOSE[4030] logger.c: — (9 headers 0 lines) —
Jun 18 13:58:08 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘5afd004e44701c00351a43664da073d7@10.10.5.10’ of Request 102: Match Found
Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 10.10.5.179 with 10.10.5.0
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 3 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 10.10.5.179:5061:
NOTIFY sip:102@10.10.5.179:5061 SIP/2.0
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK7753349d;rport
From: “Unknown” ;tag=as5b1c6841
To:
Contact:
Call-ID: 5ddd80072550f5fc3374ccbf0a5dfeb2@10.10.5.10
CSeq: 102 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
Event: message-summary
Content-Type: application/simple-message-summary
Content-Length: 90

Messages-Waiting: no
Message-Account: sip:asterisk@10.10.5.10
Voice-Message: 0/0 (0/0)


Jun 18 13:58:08 VERBOSE[4030] logger.c: Scheduling destruction of call ‘5ddd80072550f5fc3374ccbf0a5dfeb2@10.10.5.10’ in 15000 ms
Jun 18 13:58:08 VERBOSE[4030] logger.c:
<-- SIP read from 10.10.5.213:5061:
SIP/2.0 200 OK
To: ;tag=28aa6d8afd159584i1
From: “Unknown” ;tag=as15552d49
Call-ID: 2fcc3ee1293f86636d2b350a26c5f0ed@10.10.5.10
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK677eefb7
Server: Linksys/SPA941-5.1.8
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces

Jun 18 13:58:08 VERBOSE[4030] logger.c: — (10 headers 0 lines) —
Jun 18 13:58:08 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘2fcc3ee1293f86636d2b350a26c5f0ed@10.10.5.10’ of Request 102: Match Found
Jun 18 13:58:08 DEBUG[4030] acl.c: ##### Testing 10.10.5.179 with 10.10.5.0
Jun 18 13:58:08 VERBOSE[4030] logger.c: 12 headers, 3 lines
Jun 18 13:58:08 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 10.10.5.179:5060:
NOTIFY sip:101@10.10.5.179:5060 SIP/2.0
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK323e7e00;rport
From: “Unknown” ;tag=as6cd12684
To:
Contact:
Call-ID: 069cad6e4821940d6a5f48871c92293e@10.10.5.10
CSeq: 102 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
Event: message-summary
Content-Type: application/simple-message-summary
Content-Length: 90

Messages-Waiting: no
Message-Account: sip:asterisk@10.10.5.10
Voice-Message: 0/0 (0/0)


Jun 18 13:58:08 VERBOSE[4030] logger.c: Scheduling destruction of call ‘069cad6e4821940d6a5f48871c92293e@10.10.5.10’ in 15000 ms
Jun 18 13:58:08 VERBOSE[4030] logger.c:
<-- SIP read from 10.10.5.247:5060:
SIP/2.0 200 OK
To: ;tag=8d5fb3dbecbc1bcci0
From: “Unknown” ;tag=as3232e0b7
Call-ID: 5b905b370797701c49c237725f1764bb@10.10.5.10
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK3eec21c4
Server: Linksys/SPA921-5.1.8
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces

Jun 18 13:58:08 VERBOSE[4030] logger.c: — (10 headers 0 lines) —
Jun 18 13:58:08 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘5b905b370797701c49c237725f1764bb@10.10.5.10’ of Request 102: Match Found
Jun 18 13:58:08 VERBOSE[4030] logger.c: Destroying call '5b905b370797701c49c237725f1764bb@10.10.5.10’
Jun 18 13:58:08 VERBOSE[4030] logger.c: Destroying call '5afd004e44701c00351a43664da073d7@10.10.5.10’
Jun 18 13:58:08 VERBOSE[4030] logger.c: Destroying call '2fcc3ee1293f86636d2b350a26c5f0ed@10.10.5.10’
Jun 18 13:58:08 VERBOSE[4030] logger.c:
<-- SIP read from 10.10.5.245:5060:
SIP/2.0 200 OK
To: ;tag=722f5e735702b244i0
From: “Unknown” ;tag=as0e23d6c3
Call-ID: 6dee053517c82fe6271e83d731e82b6a@10.10.5.10
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK06f7936b
Server: Sipura/SPA921-4.1.10(b)
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER

Jun 18 13:58:08 VERBOSE[4030] logger.c: — (9 headers 0 lines) —
Jun 18 13:58:08 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘6dee053517c82fe6271e83d731e82b6a@10.10.5.10’ of Request 102: Match Found
Jun 18 13:58:08 VERBOSE[4030] logger.c: Destroying call '6dee053517c82fe6271e83d731e82b6a@10.10.5.10’
Jun 18 13:58:08 VERBOSE[4030] logger.c:
<-- SIP read from 10.10.5.248:5060:
SIP/2.0 200 OK
To: ;tag=d7ea4aa1757a0358i0
From: “Unknown” ;tag=as1418e5df
Call-ID: 62f39fad1cbed0ad62b203500aa6598b@10.10.5.10
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK713cc8d1
Server: Linksys/SPA921-5.1.8
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces

Jun 18 13:58:08 VERBOSE[4030] logger.c: — (10 headers 0 lines) —
Jun 18 13:58:08 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘62f39fad1cbed0ad62b203500aa6598b@10.10.5.10’ of Request 102: Match Found
Jun 18 13:58:08 VERBOSE[4030] logger.c: Destroying call '62f39fad1cbed0ad62b203500aa6598b@10.10.5.10’
Jun 18 13:58:08 VERBOSE[4030] logger.c:
<-- SIP read from 10.10.5.179:5060:
SIP/2.0 200 OK
To: ;tag=bf3b28fb4e8228c8i0
From: “Unknown” ;tag=as52d6d39a
Call-ID: 6b52a462593123370ee79a8623008065@10.10.5.10
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK17e87b7c
Server: Linksys/SPA941-5.1.8
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces

Jun 18 13:58:08 VERBOSE[4030] logger.c: — (10 headers 0 lines) —
Jun 18 13:58:08 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘6b52a462593123370ee79a8623008065@10.10.5.10’ of Request 102: Match Found
Jun 18 13:58:08 VERBOSE[4030] logger.c: Destroying call '6b52a462593123370ee79a8623008065@10.10.5.10’
Jun 18 13:58:08 VERBOSE[4030] logger.c:
<-- SIP read from 10.10.5.196:5060:
SIP/2.0 200 OK
To: ;tag=43ecabecba064cbi0
From: “Unknown” ;tag=as7c2a5807
Call-ID: 16234eb257d5c3833ab3e33a16dfa98f@10.10.5.10
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK54290c52
Server: Linksys/SPA941-5.1.8
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces

Jun 18 13:58:08 VERBOSE[4030] logger.c: — (10 headers 0 lines) —
Jun 18 13:58:08 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘16234eb257d5c3833ab3e33a16dfa98f@10.10.5.10’ of Request 102: Match Found
Jun 18 13:58:08 VERBOSE[4030] logger.c: Destroying call '16234eb257d5c3833ab3e33a16dfa98f@10.10.5.10’
Jun 18 13:58:08 VERBOSE[4030] logger.c:
<-- SIP read from 10.10.5.213:5061:
SIP/2.0 200 OK
To: ;tag=e73a62ba206aa214i0
From: “Unknown” ;tag=as3ef02d81
Call-ID: 4c30358e10baf52d27d869c72402c1ce@10.10.5.10
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK273d793a
Server: Linksys/SPA941-5.1.8
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces

Jun 18 13:58:08 VERBOSE[4030] logger.c: — (10 headers 0 lines) —
Jun 18 13:58:08 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘4c30358e10baf52d27d869c72402c1ce@10.10.5.10’ of Request 102: Match Found
Jun 18 13:58:08 VERBOSE[4030] logger.c: Destroying call '4c30358e10baf52d27d869c72402c1ce@10.10.5.10’
Jun 18 13:58:08 VERBOSE[6081] logger.c: == Loaded firmware 'iaxy.bin’
Jun 18 13:58:08 NOTICE[6081] iax2-provision.c: No IAX provisioning configuration found, IAX provisioning disabled.
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Reloading module ‘chan_local.so’ (Local Proxy Channel)
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Reloading module ‘chan_skinny.so’ (Skinny Client Control Protocol (Skinny))
Jun 18 13:58:08 NOTICE[6081] chan_skinny.c: Unable to load config skinny.conf, Skinny disabled
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Reloading module ‘chan_features.so’ (Feature Proxy Channel)
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Reloading module ‘chan_zap.so’ (Zapata Telephony w/PRI)
Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/zapata.conf’: Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/zapata.conf’: Found
Jun 18 13:58:08 VERBOSE[6081] logger.c: – Reloading module ‘app_voicemail.so’ (Comedian Mail (Voicemail System))
Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/voicemail.conf’: Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/voicemail.conf’: Found
Jun 18 13:58:08 VERBOSE[4030] logger.c:
<-- SIP read from 10.10.5.179:5060:
SIP/2.0 200 OK
To: ;tag=bf3b28fb4e8228c8i0
From: “Unknown” ;tag=as6cd12684
Call-ID: 069cad6e4821940d6a5f48871c92293e@10.10.5.10
CSeq: 102 NOTIFY
Via: SIP/2.0/UDP 10.10.5.10:5060;branch=z9hG4bK323e7e00
Server: Linksys/SPA941-5.1.8
Content-Length: 0

Jun 18 13:58:08 VERBOSE[4030] logger.c: — (8 headers 0 lines) —
Jun 18 13:58:08 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘069cad6e4821940d6a5f48871c92293e@10.10.5.10’ of Request 102: Match Found
Jun 18 13:58:08 VERBOSE[4030] logger.c: Destroying call '069cad6e4821940d6a5f48871c92293e@10.10.5.10’
Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/vm_general.inc’: Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/vm_general.inc’: Found
Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/vm_email.inc’: Jun 18 13:58:08 VERBOSE[6081] logger.c: == Parsing ‘/etc/asterisk/vm_email.inc’: Found
Jun 18 13:58:08 DEBUG[6081] app_voicemail.c: VM CID Info before msg disabled globally
Jun 18 13:58:08 DEBUG[6081] app_voicemail.c: Send Voicemail msg disabled globally
Jun 18

[quote=“emada”]also heres the last 2000 lines from debug log
[/quote]

Useless.
Need only SIP messages, only between Asterisk & VSP, including INVITEs to VSP.

[quote=“AndrewZ”]

Useless.
Need only SIP messages, only between Asterisk & VSP, including INVITEs to VSP.[/quote]

Im sorry but i cant seem to locate where this log data is kept. /var/log/asterisk/cdr-csv/Master.csv ??

Hi You need to connect with a ssh terminal on the server and then set sip debugging up for just the effected peers and then fire some calls out.

In all the info you posted I cant even see a call going out . also if posting dialplans edit them so ONLY the relevant sections are posted.

And the verbose output of a full call would be useful as all we have is the end when it went to congestion.

Ian

First let me say thank you all for trying to help me, i know it has not been easy. ok i went to the asterisk cli and ran “sip debug peer sip2” then removed sip1 from our out going trunk made a call and got the busy song again.

below is the log from the reload after removing sip1 from outgoing trunk and making a call.

Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 64.47.33.25 with 10.10.5.0
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Target address 64.47.33.25 is not local, substituting externip
Jun 19 09:13:48 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 19 09:13:48 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 64.47.33.25:5060:
OPTIONS sip:64.47.33.25 SIP/2.0
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK4024bda3;rport
From: “Unknown” ;tag=as71e087f7
To:
Contact:
Call-ID: 52f0146a495eaed73762897603bd8c52@38.119.187.34
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Thu, 19 Jun 2008 14:13:48 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 64.47.33.25 with 10.10.5.0
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Target address 64.47.33.25 is not local, substituting externip
Jun 19 09:13:48 VERBOSE[4030] logger.c: 12 headers, 0 lines
Jun 19 09:13:48 VERBOSE[4030] logger.c: Reliably Transmitting (NAT) to 64.47.33.25:5060:
OPTIONS sip:64.47.33.25 SIP/2.0
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK32e5185a;rport
From: “Unknown” ;tag=as1b571e71
To:
Contact:
Call-ID: 31f50ca665ff76053bdccc8e7aedbe8c@38.119.187.34
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Thu, 19 Jun 2008 14:13:48 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 10.10.5.213 with 10.10.5.0
Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 10.10.5.246 with 10.10.5.0
Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 10.10.5.248 with 10.10.5.0
Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 10.10.5.196 with 10.10.5.0
Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 10.10.5.245 with 10.10.5.0
Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 10.10.5.247 with 10.10.5.0
Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 10.10.5.179 with 10.10.5.0
Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 10.10.5.179 with 10.10.5.0
Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 10.10.5.213 with 10.10.5.0
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘chan_agent.so’ (Agent Proxy Channel)
Jun 19 09:13:48 NOTICE[7254] chan_agent.c: No agent configuration found – agent support disabled
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘chan_mgcp.so’ (Media Gateway Control Protocol (MGCP))
Jun 19 09:13:48 VERBOSE[4031] logger.c: Reloading MGCP
Jun 19 09:13:48 NOTICE[4031] chan_mgcp.c: Unable to load config mgcp.conf, MGCP disabled
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘chan_iax2.so’ (Inter Asterisk eXchange (Ver 2))
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/iax.conf’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/iax.conf’: Found
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/iax_registrations.conf’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/iax_registrations.conf’: Found
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/iax_additional.conf’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/iax_additional.conf’: Found
Jun 19 09:13:48 NOTICE[7254] chan_iax2.c: Ignoring bindport on reload
Jun 19 09:13:48 NOTICE[7254] chan_iax2.c: Ignoring bindaddr on reload
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Loaded firmware 'iaxy.bin’
Jun 19 09:13:48 NOTICE[7254] iax2-provision.c: No IAX provisioning configuration found, IAX provisioning disabled.
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘chan_local.so’ (Local Proxy Channel)
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘chan_skinny.so’ (Skinny Client Control Protocol (Skinny))
Jun 19 09:13:48 NOTICE[7254] chan_skinny.c: Unable to load config skinny.conf, Skinny disabled
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘chan_features.so’ (Feature Proxy Channel)
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘chan_zap.so’ (Zapata Telephony w/PRI)
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/zapata.conf’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/zapata.conf’: Found
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘app_voicemail.so’ (Comedian Mail (Voicemail System))
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/voicemail.conf’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/voicemail.conf’: Found
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/vm_general.inc’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/vm_general.inc’: Found
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/vm_email.inc’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/vm_email.inc’: Found
Jun 19 09:13:48 DEBUG[7254] app_voicemail.c: VM CID Info before msg disabled globally
Jun 19 09:13:48 DEBUG[7254] app_voicemail.c: Send Voicemail msg disabled globally
Jun 19 09:13:48 DEBUG[7254] app_voicemail.c: ENVELOPE before msg enabled globally
Jun 19 09:13:48 DEBUG[7254] app_voicemail.c: Duration info before msg enabled globally
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘app_queue.so’ (True Call Queueing)
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/queues.conf’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/queues.conf’: Found
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/queues_additional.conf’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/queues_additional.conf’: Found
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘app_enumlookup.so’ (ENUM Lookup)
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/enum.conf’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/enum.conf’: Found
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘app_hasnewvoicemail.so’ (Indicator for whether a voice mailbox has messages in a given folder.)
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘app_meetme.so’ (MeetMe conference bridge)
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/meetme.conf’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/meetme.conf’: Found
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/meetme_additional.conf’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/meetme_additional.conf’: Found
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘codec_zap.so’ (Generic Zaptel Transcoder Codec Translator)
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘codec_gsm.so’ (GSM/PCM16 (signed linear) Codec Translator)
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘codec_lpc10.so’ (LPC10 2.4kbps (signed linear) Voice Coder)
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘codec_adpcm.so’ (Adaptive Differential PCM Coder/Decoder)
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘codec_ulaw.so’ (Mu-law Coder/Decoder)
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘codec_alaw.so’ (A-law Coder/Decoder)
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘codec_g726.so’ (ITU G.726-32kbps G726 Transcoder)
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘cdr_csv.so’ (Comma Separated Values CDR Backend)
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘cdr_manager.so’ (Asterisk Call Manager CDR Backend)
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘cdr_custom.so’ (Customizable Comma Separated Values CDR Backend)
Jun 19 09:13:48 WARNING[7254] cdr_custom.c: Failed to reload configuration file.
Jun 19 09:13:48 VERBOSE[7254] logger.c: – Reloading module ‘cdr_addon_mysql.so’ (MySQL CDR Backend)
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Unregistered ‘mysql’ CDR backend
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/cdr_mysql.conf’: Jun 19 09:13:48 VERBOSE[7254] logger.c: == Parsing ‘/etc/asterisk/cdr_mysql.conf’: Found
Jun 19 09:13:48 WARNING[7254] cdr_addon_mysql.c: MySQL database sock file not specified. Using default
Jun 19 09:13:48 NOTICE[7254] cdr_addon_mysql.c: MySQL database table not specified. Assuming "cdr"
Jun 19 09:13:48 DEBUG[7254] cdr_addon_mysql.c: cdr_mysql: got hostname of localhost
Jun 19 09:13:48 DEBUG[7254] cdr_addon_mysql.c: cdr_mysql: got port of 0
Jun 19 09:13:48 DEBUG[7254] cdr_addon_mysql.c: cdr_mysql: got a timeout of 0
Jun 19 09:13:48 DEBUG[7254] cdr_addon_mysql.c: cdr_mysql: got user of asteriskuser
Jun 19 09:13:48 DEBUG[7254] cdr_addon_mysql.c: cdr_mysql: got dbname of asteriskcdrdb
Jun 19 09:13:48 DEBUG[7254] cdr_addon_mysql.c: cdr_mysql: got password of *steriskUs3r
Jun 19 09:13:48 DEBUG[7254] cdr_addon_mysql.c: Successfully connected to MySQL database.
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘033deaf12f60d61b1b655e58321991f6@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘6a5f57073e44802715dafc7750c4b187@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘79a9a6dd214bfd6a3795f4c552ed1337@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘6168503006153f312313a87c3677aa3a@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘3bf407ad13e28e812c7ccd0e0f7e9111@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘04cddeff49e0df2d0bfb671b3749262e@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘1f72aed7269417740e1b02a37ffb8a9a@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:48 VERBOSE[7254] logger.c: == Manager ‘asteriskmgr’ logged off from 127.0.0.1
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘2ce09fff114b2c824a6efbad315ab555@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘60985ea8082f5f2b2312a0337fac7321@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:48 VERBOSE[4030] logger.c:
<-- SIP read from 64.47.33.25:5060:
SIP/2.0 404 Not found
From: “Unknown” ;tag=as71e087f7
To:
Call-ID: 52f0146a495eaed73762897603bd8c52@38.119.187.34
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK4024bda3;rport
Contact:
Allow: INVITE,BYE,CANCEL,ACK,OPTIONS,SUBSCRIBE,NOTIFY,REFER
User-Agent: Asterisk PBX
Content-Length: 0

Jun 19 09:13:48 VERBOSE[4030] logger.c: — (10 headers 0 lines) —
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘52f0146a495eaed73762897603bd8c52@38.119.187.34’ of Request 102: Match Found
Jun 19 09:13:48 VERBOSE[4030] logger.c: Destroying call '52f0146a495eaed73762897603bd8c52@38.119.187.34’
Jun 19 09:13:48 VERBOSE[4030] logger.c:
<-- SIP read from 64.47.33.25:5060:
SIP/2.0 404 Not found
From: “Unknown” ;tag=as1b571e71
To:
Call-ID: 31f50ca665ff76053bdccc8e7aedbe8c@38.119.187.34
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK32e5185a;rport
Contact:
Allow: INVITE,BYE,CANCEL,ACK,OPTIONS,SUBSCRIBE,NOTIFY,REFER
User-Agent: Asterisk PBX
Content-Length: 0

Jun 19 09:13:48 VERBOSE[4030] logger.c: — (10 headers 0 lines) —
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘31f50ca665ff76053bdccc8e7aedbe8c@38.119.187.34’ of Request 102: Match Found
Jun 19 09:13:48 VERBOSE[4030] logger.c: Destroying call '31f50ca665ff76053bdccc8e7aedbe8c@38.119.187.34’
Jun 19 09:13:48 NOTICE[4030] chan_sip.c: – Re-registration for 2623844903@64.47.33.25
Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 64.47.33.25 with 10.10.5.0
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Target address 64.47.33.25 is not local, substituting externip
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Scheduled a registration timeout for 64.47.33.25 id #89246
Jun 19 09:13:48 VERBOSE[4030] logger.c: REGISTER 12 headers, 0 lines
Jun 19 09:13:48 VERBOSE[4030] logger.c: Reliably Transmitting (no NAT) to 64.47.33.25:5060:
REGISTER sip:64.47.33.25 SIP/2.0
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK6ebf58a5;rport
From: ;tag=as6bf8f47f
To:
Call-ID: 28bbbc6417dba0f6374e4fcd5de26742@127.0.1.1
CSeq: 102 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 3600
Contact:
Event: registration
Content-Length: 0


Jun 19 09:13:48 NOTICE[4030] chan_sip.c: – Re-registration for 2623844902@64.47.33.25
Jun 19 09:13:48 DEBUG[4030] acl.c: ##### Testing 64.47.33.25 with 10.10.5.0
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Target address 64.47.33.25 is not local, substituting externip
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Scheduled a registration timeout for 64.47.33.25 id #89248
Jun 19 09:13:48 VERBOSE[4030] logger.c: REGISTER 12 headers, 0 lines
Jun 19 09:13:48 VERBOSE[4030] logger.c: Reliably Transmitting (no NAT) to 64.47.33.25:5060:
REGISTER sip:64.47.33.25 SIP/2.0
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK109dc39b;rport
From: ;tag=as2bd02ba8
To:
Call-ID: 0aa0ed855ff4cff8022f9dcb775a8009@127.0.1.1
CSeq: 102 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Expires: 3600
Contact:
Event: registration
Content-Length: 0


Jun 19 09:13:48 VERBOSE[4030] logger.c:
<-- SIP read from 64.47.33.25:5060:
SIP/2.0 401 Unauthorized
From: ;tag=as6bf8f47f
To: ;tag=6901.2EB6
Call-ID: 28bbbc6417dba0f6374e4fcd5de26742@127.0.1.1
CSeq: 102 REGISTER
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK6ebf58a5;rport
Contact:
WWW-Authenticate: Digest realm=“sip.redgap.com”,qop=“auth”,opaque=“0003.BA91.E981.485A.6901.2EB8”,nonce="0003.BA91.E981.485A.6901.2EB7"
Content-Length: 0

Jun 19 09:13:48 VERBOSE[4030] logger.c: — (9 headers 0 lines) —
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘28bbbc6417dba0f6374e4fcd5de26742@127.0.1.1’ of Request 102: Match Found
Jun 19 09:13:48 VERBOSE[4030] logger.c: Responding to challenge, registration to domain/host name 64.47.33.25
Jun 19 09:13:48 VERBOSE[4030] logger.c: REGISTER 13 headers, 0 lines
Jun 19 09:13:48 VERBOSE[4030] logger.c: Reliably Transmitting (no NAT) to 64.47.33.25:5060:
REGISTER sip:64.47.33.25 SIP/2.0
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK3ff78f48;rport
From: ;tag=as7e5bc4b6
To:
Call-ID: 28bbbc6417dba0f6374e4fcd5de26742@127.0.1.1
CSeq: 103 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Authorization: Digest username=“2623844903”, realm=“sip.redgap.com”, algorithm=MD5, uri=“sip:64.47.33.25”, nonce=“0003.BA91.E981.485A.6901.2EB7”, response=“d5fb338fb7a377223f4be7865d3c3ab2”, opaque=“0003.BA91.E981.485A.6901.2EB8”, qop=auth, cnonce=“46c5cff0”, nc=00000001
Expires: 3600
Contact:
Event: registration
Content-Length: 0


Jun 19 09:13:48 VERBOSE[4030] logger.c:
<-- SIP read from 64.47.33.25:5060:
SIP/2.0 401 Unauthorized
From: ;tag=as2bd02ba8
To: ;tag=6901.2EB9
Call-ID: 0aa0ed855ff4cff8022f9dcb775a8009@127.0.1.1
CSeq: 102 REGISTER
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK109dc39b;rport
Contact:
WWW-Authenticate: Digest realm=“sip.redgap.com”,qop=“auth”,opaque=“0003.BA91.E981.485A.6901.2EBB”,nonce="0003.BA91.E981.485A.6901.2EBA"
Content-Length: 0

Jun 19 09:13:48 VERBOSE[4030] logger.c: — (9 headers 0 lines) —
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘0aa0ed855ff4cff8022f9dcb775a8009@127.0.1.1’ of Request 102: Match Found
Jun 19 09:13:48 VERBOSE[4030] logger.c: Responding to challenge, registration to domain/host name 64.47.33.25
Jun 19 09:13:48 VERBOSE[4030] logger.c: REGISTER 13 headers, 0 lines
Jun 19 09:13:48 VERBOSE[4030] logger.c: Reliably Transmitting (no NAT) to 64.47.33.25:5060:
REGISTER sip:64.47.33.25 SIP/2.0
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK7576f37c;rport
From: ;tag=as1b0f1d34
To:
Call-ID: 0aa0ed855ff4cff8022f9dcb775a8009@127.0.1.1
CSeq: 103 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Authorization: Digest username=“2623844902”, realm=“sip.redgap.com”, algorithm=MD5, uri=“sip:64.47.33.25”, nonce=“0003.BA91.E981.485A.6901.2EBA”, response=“db25637c747b02e49911b5f163825d6d”, opaque=“0003.BA91.E981.485A.6901.2EBB”, qop=auth, cnonce=“4453e55b”, nc=00000001
Expires: 3600
Contact:
Event: registration
Content-Length: 0


Jun 19 09:13:48 VERBOSE[4030] logger.c:
<-- SIP read from 64.47.33.25:5060:
SIP/2.0 200 OK
From: ;tag=as7e5bc4b6
To: ;tag=6901.2EB6
Call-ID: 28bbbc6417dba0f6374e4fcd5de26742@127.0.1.1
CSeq: 103 REGISTER
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK3ff78f48;rport
Contact: ;expires=3600
Expires: 3600
Content-Length: 0

Jun 19 09:13:48 VERBOSE[4030] logger.c: — (9 headers 0 lines) —
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘28bbbc6417dba0f6374e4fcd5de26742@127.0.1.1’ of Request 103: Match Found
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Registration successful
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Cancelling timeout 89246
Jun 19 09:13:48 VERBOSE[4030] logger.c: Scheduling destruction of call ‘28bbbc6417dba0f6374e4fcd5de26742@127.0.1.1’ in 32000 ms
Jun 19 09:13:48 NOTICE[4030] chan_sip.c: Outbound Registration: Expiry for 64.47.33.25 is 3600 sec (Scheduling reregistration in 3585 s)
Jun 19 09:13:48 VERBOSE[4030] logger.c:
<-- SIP read from 64.47.33.25:5060:
SIP/2.0 200 OK
From: ;tag=as1b0f1d34
To: ;tag=6901.2EB9
Call-ID: 0aa0ed855ff4cff8022f9dcb775a8009@127.0.1.1
CSeq: 103 REGISTER
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK7576f37c;rport
Contact: ;expires=3600
Expires: 3600
Content-Length: 0

Jun 19 09:13:48 VERBOSE[4030] logger.c: — (9 headers 0 lines) —
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘0aa0ed855ff4cff8022f9dcb775a8009@127.0.1.1’ of Request 103: Match Found
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Registration successful
Jun 19 09:13:48 DEBUG[4030] chan_sip.c: Cancelling timeout 89248
Jun 19 09:13:48 VERBOSE[4030] logger.c: Scheduling destruction of call ‘0aa0ed855ff4cff8022f9dcb775a8009@127.0.1.1’ in 32000 ms
Jun 19 09:13:48 NOTICE[4030] chan_sip.c: Outbound Registration: Expiry for 64.47.33.25 is 3600 sec (Scheduling reregistration in 3585 s)
Jun 19 09:13:52 DEBUG[4030] acl.c: ##### Testing 10.10.5.196 with 10.10.5.0
Jun 19 09:13:52 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘58dc50f80f53fb33175fa99a2bd1f3db@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:53 DEBUG[4030] acl.c: ##### Testing 10.10.5.245 with 10.10.5.0
Jun 19 09:13:53 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘3bacaf845ebf4fb75e6bc2d860afeee4@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:53 DEBUG[4030] acl.c: ##### Testing 10.10.5.247 with 10.10.5.0
Jun 19 09:13:53 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘0cf6e41b56d7c34962d32a641a1c5093@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:56 DEBUG[4030] acl.c: ##### Testing 10.10.5.213 with 10.10.5.0
Jun 19 09:13:56 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘214877004e2916ff5f74438129e33f2f@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:58 DEBUG[4030] acl.c: ##### Testing 10.10.5.246 with 10.10.5.0
Jun 19 09:13:58 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘2b4c4e4e1749b8330342acb30884ddf3@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:58 DEBUG[4030] acl.c: ##### Testing 10.10.5.248 with 10.10.5.0
Jun 19 09:13:58 DEBUG[4030] acl.c: ##### Testing 10.10.5.179 with 10.10.5.0
Jun 19 09:13:58 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘73d2c8913a98988138f45d370a3d3524@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:58 DEBUG[4030] acl.c: ##### Testing 10.10.5.179 with 10.10.5.0
Jun 19 09:13:58 DEBUG[4030] acl.c: ##### Testing 10.10.5.213 with 10.10.5.0
Jun 19 09:13:58 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘21ea000e74cef1be284c421763f8f19b@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:58 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘3b6e3ee16b21a82d20ea50a979c6a1a2@10.10.5.10’ of Request 102: Match Found
Jun 19 09:13:58 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘03d0736739452b7a416e30964e6514b1@10.10.5.10’ of Request 102: Match Found
Jun 19 09:14:04 DEBUG[4030] acl.c: ##### Testing 10.10.5.246 with 10.10.5.0
Jun 19 09:14:04 DEBUG[4030] chan_sip.c: Setting NAT on RTP to 524288
Jun 19 09:14:04 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘f8950a90-b72a6352@10.10.5.246’ of Response 101: Match Found
Jun 19 09:14:04 DEBUG[4030] chan_sip.c: Setting NAT on RTP to 524288
Jun 19 09:14:04 DEBUG[4030] chan_sip.c: Checking SIP call limits for device 107
Jun 19 09:14:04 DEBUG[4030] chan_sip.c: build_route: Contact hop: "dis"
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Macro(“SIP/107-08221bc0”, “dialout-trunk|1|3391732||”) in new stack
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “DIAL_TRUNK=1”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “DIAL_NUMBER=3391732”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “ROUTE_PASSWD=”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “1?noauth”) in new stack
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Goto (macro-dialout-trunk,s,6)
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '0’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “0?disabletrunk|1”) in new stack
Jun 19 09:14:04 DEBUG[7274] pbx.c: Not taking any branch
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “_NODEST=”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “DIAL_TRUNK_OPTIONS=tr”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “GROUP()=OUT_1”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Macro(“SIP/107-08221bc0”, “user-callerid|SKIPTTL”) in new stack
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is 'device’
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '107’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing NoOp(“SIP/107-08221bc0”, “user-callerid: device 107”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Noop
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '107’
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '107’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “AMPUSER=107”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '0’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “0?report”) in new stack
Jun 19 09:14:04 DEBUG[7274] pbx.c: Not taking any branch
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '0’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “0?start”) in new stack
Jun 19 09:14:04 DEBUG[7274] pbx.c: Not taking any branch
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '107’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “REALCALLERIDNUM=107”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing NoOp(“SIP/107-08221bc0”, “REALCALLERIDNUM is 107”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: NoOp
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '107’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “AMPUSER=107”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is 'Conference Room’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “AMPUSERCIDNAME=Conference Room”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '0’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “0?report”) in new stack
Jun 19 09:14:04 DEBUG[7274] pbx.c: Not taking any branch
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '1’
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '107’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “AMPUSERCID=107”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “CALLERID(all)=“Conference Room” <107>”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '107’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “REALCALLERIDNUM=107”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing NoOp(“SIP/107-08221bc0”, “TTL: ARG1: SKIPTTL”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Noop
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “1?continue”) in new stack
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Goto (macro-user-callerid,s,23)
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '“Conference Room” <107>'
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing NoOp(“SIP/107-08221bc0”, “Using CallerID “Conference Room” <107>”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: NoOp
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Macro
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '107’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Macro(“SIP/107-08221bc0”, “record-enable|107|OUT”) in new stack
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '0’
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '0’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “0?2:4”) in new stack
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Goto (macro-record-enable,s,4)
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '20080619-091404’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing AGI(“SIP/107-08221bc0”, “recordingcheck|20080619-091404|1213884844.154”) in new stack
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
Jun 19 09:14:04 VERBOSE[7274] logger.c: recordingcheck|20080619-091404|1213884844.154: Outbound recording enabled.
Jun 19 09:14:04 VERBOSE[7274] logger.c: recordingcheck|20080619-091404|1213884844.154: CALLFILENAME=OUT107-20080619-091404-1213884844.154
Jun 19 09:14:04 VERBOSE[7274] logger.c: – AGI Script recordingcheck completed, returning 0
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: AGI
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing MixMonitor(“SIP/107-08221bc0”, “OUT107-20080619-091404-1213884844.154.wav”) in new stack
Jun 19 09:14:04 DEBUG[7274] channel.c: Spy MixMonitor added to channel SIP/107-08221bc0
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: MixMonitor
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Macro
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '0’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “0?skipoutcid”) in new stack
Jun 19 09:14:04 DEBUG[7274] pbx.c: Not taking any branch
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “DIAL_TRUNK_OPTIONS=”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Macro(“SIP/107-08221bc0”, “outbound-callerid|1”) in new stack
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “1?start”) in new stack
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Goto (macro-outbound-callerid,s,3)
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing NoOp(“SIP/107-08221bc0”, “REALCALLERIDNUM is 107”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: NoOp
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “1?normcid”) in new stack
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Goto (macro-outbound-callerid,s,9)
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is ''
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “USEROUTCID=”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 DEBUG[7274] db.c: Unable to find key ‘107/emergency_cid’ in family 'DEVICE’
Jun 19 09:14:04 DEBUG[7274] func_db.c: DB: DEVICE/107/emergency_cid not found in database.
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is ''
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “EMERGENCYCID=”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “TRUNKOUTCID=“GrandCare Systems” <2623844902>”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “1?trunkcid”) in new stack
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Goto (macro-outbound-callerid,s,16)
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '0’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “0?usercid”) in new stack
Jun 19 09:14:04 DEBUG[7274] pbx.c: Not taking any branch
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “CALLERID(all)=“GrandCare Systems” <2623844902>”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “1?report”) in new stack
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Goto (macro-outbound-callerid,s,22)
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is '“GrandCare Systems” <2623844902>'
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing NoOp(“SIP/107-08221bc0”, “CallerID set to “GrandCare Systems” <2623844902>”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: NoOp
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Macro
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “1?nomax”) in new stack
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Goto (macro-dialout-trunk,s,17)
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing AGI(“SIP/107-08221bc0”, “fixlocalprefix”) in new stack
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
Jun 19 09:14:04 VERBOSE[7277] logger.c: == Begin MixMonitor Recording SIP/107-08221bc0
Jun 19 09:14:04 VERBOSE[7274] logger.c: – AGI Script fixlocalprefix completed, returning 0
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: AGI
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “OUTNUM=3391732”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 DEBUG[7274] pbx.c: Function result is 'SIP/SIPLine2’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Set(“SIP/107-08221bc0”, “custom=SIP/SIPLine2”) in new stack
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: Set
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '0’
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “1?gocall”) in new stack
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Goto (macro-dialout-trunk,s,22)
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 DEBUG[7274] pbx.c: Expression result is '0’
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “0?customtrunk”) in new stack
Jun 19 09:14:04 DEBUG[7274] pbx.c: Not taking any branch
Jun 19 09:14:04 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:04 VERBOSE[7274] logger.c: – Executing Dial(“SIP/107-08221bc0”, “SIP/SIPLine2/3391732|300|”) in new stack
Jun 19 09:14:04 DEBUG[7274] chan_sip.c: Setting NAT on RTP to 524288
Jun 19 09:14:04 DEBUG[7274] acl.c: ##### Testing 64.47.33.25 with 10.10.5.0
Jun 19 09:14:04 DEBUG[7274] chan_sip.c: Target address 64.47.33.25 is not local, substituting externip
Jun 19 09:14:04 DEBUG[7274] chan_sip.c: Outgoing Call for 3391732
Jun 19 09:14:04 VERBOSE[7274] logger.c: We’re at 38.119.187.34 port 18224
Jun 19 09:14:04 VERBOSE[7274] logger.c: Adding codec 0x4 (ulaw) to SDP
Jun 19 09:14:04 VERBOSE[7274] logger.c: Adding codec 0x8 (alaw) to SDP
Jun 19 09:14:04 VERBOSE[7274] logger.c: Adding non-codec 0x1 (telephone-event) to SDP
Jun 19 09:14:04 VERBOSE[7274] logger.c: 13 headers, 11 lines
Jun 19 09:14:04 VERBOSE[7274] logger.c: Reliably Transmitting (NAT) to 64.47.33.25:5060:
INVITE sip:3391732@64.47.33.25 SIP/2.0
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK58137531;rport
From: “GrandCare Systems” ;tag=as212440c0
To:
Contact:
Call-ID: 1f1328d1352ec0100298a71d2de4f56b@38.119.187.34
CSeq: 102 INVITE
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Thu, 19 Jun 2008 14:14:04 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Type: application/sdp
Content-Length: 240

v=0
o=root 4018 4018 IN IP4 38.119.187.34
s=session
c=IN IP4 38.119.187.34
t=0 0
m=audio 18224 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -


Jun 19 09:14:04 VERBOSE[7274] logger.c: – Called SIPLine2/3391732
Jun 19 09:14:04 VERBOSE[4030] logger.c:
<-- SIP read from 64.47.33.25:5060:
SIP/2.0 100 Trying
From: “GrandCare Systems” ;tag=as212440c0
To: ;tag=6912.2EEA
Call-ID: 1f1328d1352ec0100298a71d2de4f56b@38.119.187.34
CSeq: 102 INVITE
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK58137531;rport
Contact:
Content-Length: 0

Jun 19 09:14:04 VERBOSE[4030] logger.c: — (8 headers 0 lines) —
Jun 19 09:14:04 DEBUG[4030] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on ‘1f1328d1352ec0100298a71d2de4f56b@38.119.187.34’ Request 102: Found
Jun 19 09:14:09 VERBOSE[4030] logger.c:
<-- SIP read from 64.47.33.25:5060:
SIP/2.0 404 Not found
From: “GrandCare Systems” ;tag=as212440c0
To: ;tag=6912.2EEA
Call-ID: 1f1328d1352ec0100298a71d2de4f56b@38.119.187.34
CSeq: 102 INVITE
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK58137531;rport
Contact:
Content-Length: 0

Jun 19 09:14:09 VERBOSE[4030] logger.c: — (8 headers 0 lines) —
Jun 19 09:14:09 DEBUG[4030] chan_sip.c: Acked pending invite 102
Jun 19 09:14:09 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘1f1328d1352ec0100298a71d2de4f56b@38.119.187.34’ of Request 102: Match Found
Jun 19 09:14:09 VERBOSE[4030] logger.c: Transmitting (NAT) to 64.47.33.25:5060:
ACK sip:3391732@64.47.33.25 SIP/2.0
Via: SIP/2.0/UDP 38.119.187.34:5060;branch=z9hG4bK58137531;rport
From: “GrandCare Systems” ;tag=as212440c0
To: ;tag=6912.2EEA
Contact:
Call-ID: 1f1328d1352ec0100298a71d2de4f56b@38.119.187.34
CSeq: 102 ACK
User-Agent: Asterisk PBX
Max-Forwards: 70
Content-Length: 0


Jun 19 09:14:09 VERBOSE[7274] logger.c: – SIP/SIPLine2-08227100 is circuit-busy
Jun 19 09:14:09 DEBUG[7274] chan_sip.c: update_call_counter(3391732) - decrement call limit counter
Jun 19 09:14:09 VERBOSE[7274] logger.c: == Everyone is busy/congested at this time (1:0/1/0)
Jun 19 09:14:09 DEBUG[7274] app_dial.c: Exiting with DIALSTATUS=CONGESTION.
Jun 19 09:14:09 DEBUG[7274] app_macro.c: Executed application: Dial
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing Goto(“SIP/107-08221bc0”, “s-CONGESTION|1”) in new stack
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Goto (macro-dialout-trunk,s-CONGESTION,1)
Jun 19 09:14:09 DEBUG[7274] app_macro.c: Executed application: Goto
Jun 19 09:14:09 DEBUG[7274] pbx.c: Expression result is ‘1’
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “1?noreport”) in new stack
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Goto (macro-dialout-trunk,s-CONGESTION,3)
Jun 19 09:14:09 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing NoOp(“SIP/107-08221bc0”, “TRUNK Dial failed due to CONGESTION - failing through to other trunks”) in new stack
Jun 19 09:14:09 DEBUG[7274] app_macro.c: Executed application: Noop
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing Macro(“SIP/107-08221bc0”, “outisbusy|”) in new stack
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing Playback(“SIP/107-08221bc0”, “all-circuits-busy-now|noanswer”) in new stack
Jun 19 09:14:09 WARNING[7274] file.c: File all-circuits-busy-now does not exist in any format
Jun 19 09:14:09 WARNING[7274] file.c: Unable to open all-circuits-busy-now (format ulaw): No such file or directory
Jun 19 09:14:09 WARNING[7274] app_playback.c: ast_streamfile failed on SIP/107-08221bc0 for all-circuits-busy-now|noanswer
Jun 19 09:14:09 DEBUG[7274] app_macro.c: Executed application: Playback
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing Playback(“SIP/107-08221bc0”, “pls-try-call-later|noanswer”) in new stack
Jun 19 09:14:09 WARNING[7274] file.c: File pls-try-call-later does not exist in any format
Jun 19 09:14:09 WARNING[7274] file.c: Unable to open pls-try-call-later (format ulaw): No such file or directory
Jun 19 09:14:09 WARNING[7274] app_playback.c: ast_streamfile failed on SIP/107-08221bc0 for pls-try-call-later|noanswer
Jun 19 09:14:09 DEBUG[7274] app_macro.c: Executed application: Playback
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing Macro(“SIP/107-08221bc0”, “hangupcall”) in new stack
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing ResetCDR(“SIP/107-08221bc0”, “w”) in new stack
Jun 19 09:14:09 DEBUG[7274] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Jun 19 09:14:09 DEBUG[7274] cdr_addon_mysql.c: cdr_mysql: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,uniqueid) VALUES (‘2008-06-19 09:14:04’,’“GrandCare Systems” <2623844902>’,‘2623844902’,‘3391732’,‘from-internal’, ‘SIP/107-08221bc0’,‘SIP/SIPLine2-08227100’,‘ResetCDR’,‘w’,5,0,‘FAILED’,3,’’,‘1213884844.154’)
Jun 19 09:14:09 DEBUG[7274] app_macro.c: Executed application: ResetCDR
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing NoCDR(“SIP/107-08221bc0”, “”) in new stack
Jun 19 09:14:09 NOTICE[7274] cdr.c: CDR on channel ‘SIP/107-08221bc0’ not posted
Jun 19 09:14:09 NOTICE[7274] cdr.c: CDR on channel ‘SIP/107-08221bc0’ lacks end
Jun 19 09:14:09 DEBUG[7274] app_macro.c: Executed application: NoCDR
Jun 19 09:14:09 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “1?skiprg”) in new stack
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Goto (macro-hangupcall,s,6)
Jun 19 09:14:09 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:09 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “1?skipblkvm”) in new stack
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Goto (macro-hangupcall,s,9)
Jun 19 09:14:09 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:09 DEBUG[7274] pbx.c: Expression result is '1’
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing GotoIf(“SIP/107-08221bc0”, “1?theend”) in new stack
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Goto (macro-hangupcall,s,11)
Jun 19 09:14:09 DEBUG[7274] app_macro.c: Executed application: GotoIf
Jun 19 09:14:09 VERBOSE[7274] logger.c: – Executing Hangup(“SIP/107-08221bc0”, “”) in new stack
Jun 19 09:14:09 VERBOSE[7274] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘SIP/107-08221bc0’ in macro 'hangupcall’
Jun 19 09:14:09 VERBOSE[7274] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘SIP/107-08221bc0’ in macro 'outisbusy’
Jun 19 09:14:09 VERBOSE[7274] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/107-08221bc0’
Jun 19 09:14:09 DEBUG[7274] channel.c: Spy MixMonitor removed from channel SIP/107-08221bc0
Jun 19 09:14:09 DEBUG[7274] chan_sip.c: update_call_counter(107) - decrement call limit counter
Jun 19 09:14:09 VERBOSE[7277] logger.c: == End MixMonitor Recording SIP/107-08221bc0
Jun 19 09:14:09 VERBOSE[4030] logger.c: Destroying call '1f1328d1352ec0100298a71d2de4f56b@38.119.187.34’
Jun 19 09:14:09 DEBUG[4030] chan_sip.c: Stopping retransmission on ‘f8950a90-b72a6352@10.10.5.246’ of Response 102: Match Found
Jun 19 09:14:15 VERBOSE[4030] logger.c:
<-- SIP read from 64.47.33.25:5060:
OPTIONS sip:4903@38.119.187.34:5060 SIP/2.0
From: ;tag=691D.3019
To:
Call-ID: 0003.BA91.E981.485A.691D.3019
CSeq: 5442 OPTIONS
Max-Forwards: 70
Via: SIP/2.0/UDP 64.47.33.25:5060;branch=z9hG4bK485A.691D.30195442.19212F40.0000056B
Via: SIP/2.0/UDP 64.47.33.67:5062;branch=z9hG4bK485A.691D.30195442
Contact:
Allow: INVITE,BYE,INFO,PRACK,CANCEL,ACK,OPTIONS,SUBSCRIBE,NOTIFY,REGISTER,REFER,UPDATE
Content-Length: 0

Jun 19 09:14:15 VERBOSE[4030] logger.c: — (11 headers 0 lines) —
Jun 19 09:14:15 DEBUG[4030] acl.c: ##### Testing 64.47.33.25 with 10.10.5.0
Jun 19 09:14:15 DEBUG[4030] chan_sip.c: Target address 64.47.33.25 is not local, substituting externip
Jun 19 09:14:15 VERBOSE[4030] logger.c: Looking for 4903 in from-sip-external (domain 38.119.187.34)
Jun 19 09:14:15 VERBOSE[4030] logger.c: Transmitting (no NAT) to 64.47.33.25:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 64.47.33.25:5060;branch=z9hG4bK485A.691D.30195442.19212F40.0000056B;received=64.47.33.25
Via: SIP/2.0/UDP 64.47.33.67:5062;branch=z9hG4bK485A.691D.30195442
From: ;tag=691D.3019
To: ;tag=as50f63845
Call-ID: 0003.BA91.E981.485A.691D.3019
CSeq: 5442 OPTIONS
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact:
Accept: application/sdp
Content-Length: 0


Jun 19 09:14:15 VERBOSE[4030] logger.c: Destroying call '0003.BA91.E981.485A.691D.3019’
Jun 19 09:14:20 DEBUG[4030] chan_sip.c: Auto destroying call '28bbbc6417dba0f6374e4fcd5de26742@127.0.1.1’
Jun 19 09:14:20 VERBOSE[4030] logger.c: Destroying call '28bbbc6417dba0f6374e4fcd5de26742@127.0.1.1’
Jun 19 09:14:20 DEBUG[4030] chan_sip.c: Auto destroying call '0aa0ed855ff4cff8022f9dcb775a8009@127.0.1.1’
Jun 19 09:14:20 VERBOSE[4030] logger.c: Destroying call '0aa0ed855ff4cff8022f9dcb775a8009@127.0.1.1’
Jun 19 09:14:33 DEBUG[7281] manager.c: Manager received command 'login’
Jun 19 09:14:33 VERBOSE[7281] logger.c: == Parsing ‘/etc/asterisk/manager.conf’: Jun 19 09:14:33 VERBOSE[7281] logger.c: == Parsing ‘/etc/asterisk/manager.conf’: Found
Jun 19 09:14:33 DEBUG[7281] acl.c: 0.0.0.0/0.0.0.0/0.0.0.0 appended to acl for peer
Jun 19 09:14:33 DEBUG[7281] acl.c: 127.0.0.1/255.255.255.0/255.255.255.0 appended to acl for peer
Jun 19 09:14:33 DEBUG[7281] acl.c: ##### Testing 127.0.0.1 with 0.0.0.0
Jun 19 09:14:33 DEBUG[7281] acl.c: ##### Testing 127.0.0.1 with 127.0.0.0
Jun 19 09:14:33 VERBOSE[7281] logger.c: == Manager ‘asteriskmgr’ logged on from 127.0.0.1
Jun 19 09:14:33 VERBOSE[7281] logger.c: == Manager ‘asteriskmgr’ logged on from 127.0.0.1