rendered paste bodyul 31 01:11:56 VERBOSE[1412] logger.c: Asterisk Event Logger restarted
Jul 31 01:11:56 VERBOSE[1412] logger.c: Asterisk Queue Logger restarted
Jul 31 01:12:01 VERBOSE[498] logger.c: -- Accepting AUTHENTICATED call from 71.112.121.192:
> requested format = gsm,
> requested prefs = (),
> actual format = gsm,
> host prefs = (gsm),
> priority = mine
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Macro("IAX2/101-4", "dialout-enum|2|4256063864||") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1PASSWD?NOPASSWD") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Goto (macro-dialout-enum,s,3)
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Macro("IAX2/101-4", "user-callerid") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?report") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Not taking any branch
Jul 31 01:12:01 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?start") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Not taking any branch
Jul 31 01:12:01 DEBUG[1429] pbx.c: Function result is '101'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "REALCALLERIDNUM=101") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "REALCALLERIDNUM is 101") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Function result is '101'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "AMPUSER=101") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Function result is 'BJ'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "AMPUSERCIDNAME=BJ") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?report") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Not taking any branch
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "CALLERID(all)=BJ <101>") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Function result is '"BJ" <101>'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "Using CallerID "BJ" <101>") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Function result is '101'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Macro("IAX2/101-4", "record-enable|101|OUT") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Function result is '0'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0 > 0?2:4") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Goto (macro-record-enable,s,4)
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing DeadAGI("IAX2/101-4", "recordingcheck|20060731-011201|1154333521.18") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
Jul 31 01:12:01 VERBOSE[1429] logger.c: recordingcheck|20060731-011201|1154333521.18: Outbound recording not enabled
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- AGI Script recordingcheck completed, returning 0
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "No recording needed") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Macro("IAX2/101-4", "outbound-callerid|2") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1?start") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Goto (macro-outbound-callerid,s,3)
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "REALCALLERIDNUM is 101") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Function result is ''
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "USEROUTCID=") in new stack
Jul 31 01:12:01 DEBUG[1429] db.c: Unable to find key '101/emergency_cid' in family 'DEVICE'
Jul 31 01:12:01 DEBUG[1429] func_db.c: DB: DEVICE/101/emergency_cid not found in database.
Jul 31 01:12:01 DEBUG[1429] pbx.c: Function result is ''
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "EMERGENCYCID=") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "TRUNKOUTCID=") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1?trunkcid") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Goto (macro-outbound-callerid,s,11)
Jul 31 01:12:01 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1?usercid") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Goto (macro-outbound-callerid,s,13)
Jul 31 01:12:01 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1?report") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Goto (macro-outbound-callerid,s,15)
Jul 31 01:12:01 DEBUG[1429] pbx.c: Function result is '"BJ" <101>'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "CallerID set to "BJ" <101>") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "GROUP()=OUT_2") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Function result is '1'
Jul 31 01:12:01 WARNING[1429] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected $end, expecting TOK_MINUS or TOK_COMPL or TOK_LP or TOKEN; Input:
1 >
^
Jul 31 01:12:01 WARNING[1429] ast_expr2.fl: If you have questions, please refer to doc/README.variables in the asterisk source.
Jul 31 01:12:01 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?nochans") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Not taking any branch
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "DIAL_NUMBER=4256063864") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "DIAL_TRUNK=2") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing AGI("IAX2/101-4", "fixlocalprefix") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
Jul 31 01:12:01 VERBOSE[1429] logger.c: fixlocalprefix: Added prefix. New number: 14256063864
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- AGI Script fixlocalprefix completed, returning 0
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "E164NETWORKS=e164.arpa-e164.info-e164.org") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?begin") in new stack
Jul 31 01:12:01 DEBUG[1429] pbx.c: Not taking any branch
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "DIAL_NUMBER=+14256063864") in new stack
Jul 31 01:12:01 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "E164NETWORKS is e164.arpa-e164.info-e164.org") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?failedtotally") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Not taking any branch
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is 'e164.arpa'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "ENUMNET=e164.arpa") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is 'e164.info-e164.org'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "E164NETWORKS=e164.info-e164.org") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "E164NETWORKS is now e164.info-e164.org") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "ENUMNET is e164.arpa") in new stack
Jul 31 01:12:02 DEBUG[1429] enum.c: No such number found: 4.6.8.3.6.0.6.5.2.4.1.e164.arpa (Success)
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is ''
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "ENUMCOUNT=") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "ENUMPTR=0") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "LOOKUPBUG=0") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?continue:failed") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-dialout-enum,s,47)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "EnumLookup failed on network e164.arpa") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Goto("IAX2/101-4", "begin") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-dialout-enum,s,14)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "E164NETWORKS is e164.info-e164.org") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?failedtotally") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Not taking any branch
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is 'e164.info'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "ENUMNET=e164.info") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is 'e164.org'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "E164NETWORKS=e164.org") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "E164NETWORKS is now e164.org") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "ENUMNET is e164.info") in new stack
Jul 31 01:12:02 DEBUG[498] chan_iax2.c: Ooh, voice format changed to 2
Jul 31 01:12:02 DEBUG[1429] enum.c: No such number found: 4.6.8.3.6.0.6.5.2.4.1.e164.info (Success)
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is ''
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "ENUMCOUNT=") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "ENUMPTR=0") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "LOOKUPBUG=0") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?continue:failed") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-dialout-enum,s,47)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "EnumLookup failed on network e164.info") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Goto("IAX2/101-4", "begin") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-dialout-enum,s,14)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "E164NETWORKS is e164.org") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?failedtotally") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Not taking any branch
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is 'e164.org'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "ENUMNET=e164.org") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is ''
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "E164NETWORKS=") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "E164NETWORKS is now ") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "ENUMNET is e164.org") in new stack
Jul 31 01:12:02 DEBUG[1429] enum.c: No such number found: 4.6.8.3.6.0.6.5.2.4.1.e164.org (Success)
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is ''
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "ENUMCOUNT=") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "ENUMPTR=0") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "LOOKUPBUG=0") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?continue:failed") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-dialout-enum,s,47)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "EnumLookup failed on network e164.org") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Goto("IAX2/101-4", "begin") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-dialout-enum,s,14)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "E164NETWORKS is ") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1?failedtotally") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-dialout-enum,s,49)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "EnumLookup failed -- no more networks to try") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Goto("IAX2/101-4", "end") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-dialout-enum,s,52)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "Exiting macro-dialout-enum") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Macro("IAX2/101-4", "dialout-trunk|5|4256063864||") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "DIAL_TRUNK=5") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "DIAL_NUMBER=4256063864") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "ROUTE_PASSWD=") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1?noauth") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-dialout-trunk,s,6)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "GROUP()=OUT_5") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Macro("IAX2/101-4", "user-callerid") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?report") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Not taking any branch
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1?start") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-user-callerid,s,4)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "REALCALLERIDNUM is 101") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is '101'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "AMPUSER=101") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is 'BJ'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "AMPUSERCIDNAME=BJ") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?report") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Not taking any branch
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "CALLERID(all)=BJ <101>") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is '"BJ" <101>'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "Using CallerID "BJ" <101>") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is '101'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Macro("IAX2/101-4", "record-enable|101|OUT") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is '0'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0 > 0?2:4") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-record-enable,s,4)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing DeadAGI("IAX2/101-4", "recordingcheck|20060731-011202|1154333521.18") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
Jul 31 01:12:02 VERBOSE[1429] logger.c: recordingcheck|20060731-011202|1154333521.18: Outbound recording not enabled
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- AGI Script recordingcheck completed, returning 0
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "No recording needed") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Macro("IAX2/101-4", "outbound-callerid|5") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1?start") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-outbound-callerid,s,3)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "REALCALLERIDNUM is 101") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is ''
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "USEROUTCID=") in new stack
Jul 31 01:12:02 DEBUG[1429] db.c: Unable to find key '101/emergency_cid' in family 'DEVICE'
Jul 31 01:12:02 DEBUG[1429] func_db.c: DB: DEVICE/101/emergency_cid not found in database.
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is ''
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "EMERGENCYCID=") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "TRUNKOUTCID=") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1?trunkcid") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-outbound-callerid,s,11)
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1?usercid") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-outbound-callerid,s,13)
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1?report") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-outbound-callerid,s,15)
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is '"BJ" <101>'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing NoOp("IAX2/101-4", "CallerID set to "BJ" <101>") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '1'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "1?nomax") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Goto (macro-dialout-trunk,s,12)
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing AGI("IAX2/101-4", "fixlocalprefix") in new stack
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
Jul 31 01:12:02 VERBOSE[1429] logger.c: fixlocalprefix: Added prefix. New number: 14256063864
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- AGI Script fixlocalprefix completed, returning 0
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "OUTNUM=14256063864") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Function result is 'IAX2/voxee'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Set("IAX2/101-4", "custom=IAX2/voxee") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Expression result is '0'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing GotoIf("IAX2/101-4", "0?customtrunk") in new stack
Jul 31 01:12:02 DEBUG[1429] pbx.c: Not taking any branch
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Executing Dial("IAX2/101-4", "IAX2/voxee/14256063864|120|r") in new stack
Jul 31 01:12:02 DEBUG[491] channel.c: Avoiding initial deadlock for 'IAX2/voxee-5'
Jul 31 01:12:02 VERBOSE[1429] logger.c: -- Called voxee/14256063864
Jul 31 01:12:02 VERBOSE[498] logger.c: -- Call accepted by 66.246.246.52 (format gsm)
Jul 31 01:12:02 VERBOSE[498] logger.c: -- Format for call is gsm
Jul 31 01:12:04 DEBUG[498] chan_iax2.c: Immediately destroying 4, having received hangup
Jul 31 01:12:04 DEBUG[1429] chan_iax2.c: We're hanging up IAX2/voxee-5 now...
Jul 31 01:12:04 VERBOSE[1429] logger.c: -- Hungup 'IAX2/voxee-5'
Jul 31 01:12:04 DEBUG[1429] app_dial.c: Exiting with DIALSTATUS=CANCEL.
Jul 31 01:12:04 VERBOSE[1429] logger.c: == Spawn extension (macro-dialout-trunk, s, 16) exited non-zero on 'IAX2/101-4' in macro 'dialout-trunk'
Jul 31 01:12:04 VERBOSE[1429] logger.c: == Spawn extension (macro-dialout-trunk, s, 16) exited non-zero on 'IAX2/101-4'
Jul 31 01:12:04 DEBUG[1429] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Jul 31 01:12:04 DEBUG[1429] 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 ('2006-07-31 01:12:01','\"BJ\" <101>','101','4256063864','from-internal', 'IAX2/101-4','IAX2/voxee-5','Dial','IAX2/voxee/14256063864|120|r',3,0,'NO ANSWER',3,'','1154333521.18')
Jul 31 01:12:04 DEBUG[1429] chan_iax2.c: We're hanging up IAX2/101-4 now...
Jul 31 01:12:04 DEBUG[1429] chan_iax2.c: Really destroying IAX2/101-4 now...
Jul 31 01:12:04 VERBOSE[1429] logger.c: -- Hungup 'IAX2/101-4'
Jul 31 01:12:04 VERBOSE[1429] logger.c: -- Hungup 'IAX2/101-4'