I have a fresh install of PIAF with Incredible PBX. I have 2 Polycom phones and one soft phone all calling each other. I used the Google voice module that set up the trunk and route automatically. I did not make any changes other than adding extensions and adding the google voice infomation. When i dial without a 1 i get “all circuits are busy” when i dail with a 1 i get “your call cannot be completed as dialed”
here are the log files.
[2012-07-09 03:27:07] VERBOSE[7828] config.c: == Parsing ‘/etc/asterisk/logger.conf’: [2012-07-09 03:27:07] VERBOSE[7828] config.c: == Found
[2012-07-09 03:27:07] VERBOSE[7828] config.c: == Parsing ‘/etc/asterisk/logger_general_additional.conf’: [2012-07-09 03:27:07] VERBOSE[7828] config.c: == Found
[2012-07-09 03:27:07] VERBOSE[7828] config.c: == Parsing ‘/etc/asterisk/logger_general_custom.conf’: [2012-07-09 03:27:07] VERBOSE[7828] config.c: == Found
[2012-07-09 03:27:07] VERBOSE[7828] config.c: == Parsing ‘/etc/asterisk/logger_logfiles_additional.conf’: [2012-07-09 03:27:07] VERBOSE[7828] config.c: == Found
[2012-07-09 03:27:07] VERBOSE[7828] config.c: == Parsing ‘/etc/asterisk/logger_logfiles_custom.conf’: [2012-07-09 03:27:07] VERBOSE[7828] config.c: == Found
[2012-07-09 03:27:07] VERBOSE[7828] logger.c: Asterisk Queue Logger restarted
[2012-07-09 03:27:07] VERBOSE[7828] asterisk.c: – Remote UNIX connection disconnected
[2012-07-09 14:34:46] VERBOSE[2858] netsock2.c: == Using SIP RTP TOS bits 184
[2012-07-09 14:34:46] VERBOSE[2858] netsock2.c: == Using SIP RTP CoS mark 5
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [2102184944@from-internal:1] Macro(“SIP/1010-00000004”, “user-callerid,LIMIT,”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/1010-00000004”, “AMPUSER=1010”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:2] GotoIf(“SIP/1010-00000004”, “0?report”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:3] ExecIf(“SIP/1010-00000004”, “1?Set(REALCALLERIDNUM=1010)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:4] Set(“SIP/1010-00000004”, “AMPUSER=1010”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/1010-00000004”, “AMPUSERCIDNAME=1010”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“SIP/1010-00000004”, “0?report”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:7] Set(“SIP/1010-00000004”, “AMPUSERCID=1010”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:8] Set(“SIP/1010-00000004”, “CALLERID(all)=“1010” <1010>”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:9] GotoIf(“SIP/1010-00000004”, “0?limit”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:10] ExecIf(“SIP/1010-00000004”, “1?Set(GROUP(concurrency_limit)=1010)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:11] GosubIf(“SIP/1010-00000004”, “0?sub-ccss,s,1(from-internal,2102184944)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:12] ExecIf(“SIP/1010-00000004”, “0?Set(CHANNEL(language)=)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:13] GotoIf(“SIP/1010-00000004”, “1?continue”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (macro-user-callerid,s,26)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:26] Set(“SIP/1010-00000004”, “CALLERID(number)=1010”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:27] Set(“SIP/1010-00000004”, “CALLERID(name)=1010”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-user-callerid:28] Set(“SIP/1010-00000004”, “CHANNEL(language)=en”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [2102184944@from-internal:2] Set(“SIP/1010-00000004”, “MOHCLASS=default”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [2102184944@from-internal:3] Set(“SIP/1010-00000004”, “_NODEST=”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [2102184944@from-internal:4] Gosub(“SIP/1010-00000004”, “sub-record-check,s,1(out,2102184944,)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“SIP/1010-00000004”, “1?check”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (sub-record-check,s,6)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:6] Set(“SIP/1010-00000004”, “__MON_FMT=wav”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:7] GotoIf(“SIP/1010-00000004”, “1?next”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (sub-record-check,s,10)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:10] ExecIf(“SIP/1010-00000004”, “0?Return()”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:11] GotoIf(“SIP/1010-00000004”, “0?out,1”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:12] Set(“SIP/1010-00000004”, “__REC_STATUS=INITIALIZED”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:13] ExecIf(“SIP/1010-00000004”, “0?Set(__REC_POLICY_MODE=)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:14] Set(“SIP/1010-00000004”, “NOW=1341862486”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:15] Set(“SIP/1010-00000004”, “__DAY=09”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:16] Set(“SIP/1010-00000004”, “__MONTH=07”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:17] Set(“SIP/1010-00000004”, “__YEAR=2012”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:18] Set(“SIP/1010-00000004”, “__TIMESTR=20120709-143446”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:19] Set(“SIP/1010-00000004”, “__FROMEXTEN=1010”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:20] Set(“SIP/1010-00000004”, “__CALLFILENAME=out-2102184944-1010-20120709-143446-1341862486.10”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-record-check:21] Goto(“SIP/1010-00000004”, “out,1”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (sub-record-check,out,1)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [out@sub-record-check:1] ExecIf(“SIP/1010-00000004”, “1?Set(__REC_POLICY_MODE=dontcare)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [out@sub-record-check:2] GosubIf(“SIP/1010-00000004”, “0?record,1(exten,2102184944,1010)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [out@sub-record-check:3] Return(“SIP/1010-00000004”, “”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [2102184944@from-internal:5] Macro(“SIP/1010-00000004”, “dialout-trunk,1,12102184944,”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:1] Set(“SIP/1010-00000004”, “DIAL_TRUNK=1”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:2] GosubIf(“SIP/1010-00000004”, “0?sub-pincheck,s,1()”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/1010-00000004”, “0?disabletrunk,1”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:4] Set(“SIP/1010-00000004”, “DIAL_NUMBER=12102184944”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:5] Set(“SIP/1010-00000004”, “DIAL_TRUNK_OPTIONS=tr”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:6] Set(“SIP/1010-00000004”, “OUTBOUND_GROUP=OUT_1”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/1010-00000004”, “1?nomax”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (macro-dialout-trunk,s,9)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/1010-00000004”, “0?skipoutcid”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:10] Set(“SIP/1010-00000004”, “DIAL_TRUNK_OPTIONS=”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:11] Macro(“SIP/1010-00000004”, “outbound-callerid,1”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outbound-callerid:1] ExecIf(“SIP/1010-00000004”, “0?Set(CALLERPRES()=)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outbound-callerid:2] ExecIf(“SIP/1010-00000004”, “0?Set(REALCALLERIDNUM=1010)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outbound-callerid:3] GotoIf(“SIP/1010-00000004”, “1?normcid”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (macro-outbound-callerid,s,6)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outbound-callerid:6] Set(“SIP/1010-00000004”, “USEROUTCID=”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outbound-callerid:7] Set(“SIP/1010-00000004”, “EMERGENCYCID=”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outbound-callerid:8] Set(“SIP/1010-00000004”, “TRUNKOUTCID=2102017015”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outbound-callerid:9] GotoIf(“SIP/1010-00000004”, “1?trunkcid”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (macro-outbound-callerid,s,12)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outbound-callerid:12] ExecIf(“SIP/1010-00000004”, “1?Set(CALLERID(all)=2102017015)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outbound-callerid:13] ExecIf(“SIP/1010-00000004”, “0?Set(CALLERID(all)=)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outbound-callerid:14] ExecIf(“SIP/1010-00000004”, “0?Set(CALLERID(all)=)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outbound-callerid:15] ExecIf(“SIP/1010-00000004”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:12] GosubIf(“SIP/1010-00000004”, “1?sub-flp-1,s,1()”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-flp-1:1] ExecIf(“SIP/1010-00000004”, “0?Set(TARGET_FLP_1=112102184944)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-flp-1:2] GotoIf(“SIP/1010-00000004”, “0?match”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@sub-flp-1:3] Return(“SIP/1010-00000004”, “”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:13] Set(“SIP/1010-00000004”, “OUTNUM=12102184944”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:14] Set(“SIP/1010-00000004”, “custom=AMP”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:15] ExecIf(“SIP/1010-00000004”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:16] ExecIf(“SIP/1010-00000004”, “0?Set(DIAL_TRUNK_OPTIONS=M(confirm))”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:17] Macro(“SIP/1010-00000004”, “dialout-trunk-predial-hook,”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/1010-00000004”, “”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/1010-00000004”, “0?bypass,1”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:19] ExecIf(“SIP/1010-00000004”, “1?Set(CONNECTEDLINE(num,i)=12102184944)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:20] ExecIf(“SIP/1010-00000004”, “1?Set(CONNECTEDLINE(name,i)=CID:2102017015)”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:21] GotoIf(“SIP/1010-00000004”, “1?customtrunk”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (macro-dialout-trunk,s,25)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:25] Set(“SIP/1010-00000004”, “pre_num=AMP:local/”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:26] Set(“SIP/1010-00000004”, “the_num=OUTNUM”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:27] Set(“SIP/1010-00000004”, “post_num=@googlevoice-robmorgan210gmailcom”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:28] GotoIf(“SIP/1010-00000004”, “1?outnum:skipoutnum”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (macro-dialout-trunk,s,29)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:29] Set(“SIP/1010-00000004”, “the_num=12102184944”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:30] Dial(“SIP/1010-00000004”, “local/12102184944@googlevoice-robmorgan210gmailcom,300,”) in new stack
[2012-07-09 14:34:46] NOTICE[16511] chan_local.c: No such extension/context 12102184944@googlevoice-robmorgan210gmailcom while calling Local channel
[2012-07-09 14:34:46] VERBOSE[16511] app_dial.c: – Couldn’t call local/12102184944@googlevoice-robmorgan210gmailcom
[2012-07-09 14:34:46] VERBOSE[16511] app_dial.c: == Everyone is busy/congested at this time (0:0/0/0)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:31] NoOp(“SIP/1010-00000004”, “Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 0”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-dialout-trunk:32] Goto(“SIP/1010-00000004”, “s-CHANUNAVAIL,1”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set(“SIP/1010-00000004”, “RC=0”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto(“SIP/1010-00000004”, “0,1”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (macro-dialout-trunk,0,1)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [0@macro-dialout-trunk:1] Goto(“SIP/1010-00000004”, “continue,1”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (macro-dialout-trunk,continue,1)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [continue@macro-dialout-trunk:1] GotoIf(“SIP/1010-00000004”, “1?noreport”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Goto (macro-dialout-trunk,continue,3)
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [continue@macro-dialout-trunk:3] NoOp(“SIP/1010-00000004”, “TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 0 - failing through to other trunks”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [continue@macro-dialout-trunk:4] Set(“SIP/1010-00000004”, “CALLERID(number)=1010”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [2102184944@from-internal:6] Macro(“SIP/1010-00000004”, “outisbusy,”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outisbusy:1] Progress(“SIP/1010-00000004”, “”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outisbusy:2] GotoIf(“SIP/1010-00000004”, “0?emergency,1”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outisbusy:3] GotoIf(“SIP/1010-00000004”, “0?intracompany,1”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] pbx.c: – Executing [s@macro-outisbusy:4] Playback(“SIP/1010-00000004”, “all-circuits-busy-now&pls-try-call-later, noanswer”) in new stack
[2012-07-09 14:34:46] VERBOSE[16511] file.c: – <SIP/1010-00000004> Playing ‘all-circuits-busy-now.gsm’ (language ‘en’)
[2012-07-09 14:34:47] VERBOSE[16511] file.c: – <SIP/1010-00000004> Playing ‘pls-try-call-later.gsm’ (language ‘en’)
[2012-07-09 14:34:50] VERBOSE[16511] pbx.c: – Executing [s@macro-outisbusy:5] Congestion(“SIP/1010-00000004”, “20”) in new stack
[2012-07-09 14:34:50] VERBOSE[16511] app_macro.c: == Spawn extension (macro-outisbusy, s, 5) exited non-zero on ‘SIP/1010-00000004’ in macro ‘outisbusy’
[2012-07-09 14:34:50] VERBOSE[16511] pbx.c: == Spawn extension (from-internal, 2102184944, 6) exited non-zero on ‘SIP/1010-00000004’
[2012-07-09 14:34:50] VERBOSE[16511] pbx.c: – Executing [h@from-internal:1] Hangup(“SIP/1010-00000004”, “”) in new stack
[2012-07-09 14:34:50] VERBOSE[16511] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/1010-00000004’
[2012-07-09 14:34:57] VERBOSE[2858] netsock2.c: == Using SIP RTP TOS bits 184
[2012-07-09 14:34:57] VERBOSE[2858] netsock2.c: == Using SIP RTP CoS mark 5
[2012-07-09 14:34:57] VERBOSE[16514] pbx.c: – Executing [12102184944@from-internal:1] ResetCDR(“SIP/1010-00000005”, “”) in new stack
[2012-07-09 14:34:57] VERBOSE[16514] pbx.c: – Executing [12102184944@from-internal:2] NoCDR(“SIP/1010-00000005”, “”) in new stack
[2012-07-09 14:34:57] VERBOSE[16514] pbx.c: – Executing [12102184944@from-internal:3] Progress(“SIP/1010-00000005”, “”) in new stack
[2012-07-09 14:34:57] VERBOSE[16514] pbx.c: – Executing [12102184944@from-internal:4] Wait(“SIP/1010-00000005”, “1”) in new stack
[2012-07-09 14:34:58] VERBOSE[16514] pbx.c: – Executing [12102184944@from-internal:5] Progress(“SIP/1010-00000005”, “”) in new stack
[2012-07-09 14:34:58] VERBOSE[16514] pbx.c: – Executing [12102184944@from-internal:6] Playback(“SIP/1010-00000005”, “silence/1&cannot-complete-as-dialed&check-number-dial-again,noanswer”) in new stack
[2012-07-09 14:34:58] VERBOSE[16514] file.c: – <SIP/1010-00000005> Playing ‘silence/1.gsm’ (language ‘en’)
[2012-07-09 14:34:59] VERBOSE[16514] file.c: – <SIP/1010-00000005> Playing ‘cannot-complete-as-dialed.gsm’ (language ‘en’)
[2012-07-09 14:35:02] VERBOSE[16514] file.c: – <SIP/1010-00000005> Playing ‘check-number-dial-again.gsm’ (language ‘en’)
[2012-07-09 14:35:03] VERBOSE[16514] pbx.c: == Spawn extension (from-internal, 12102184944, 6) exited non-zero on ‘SIP/1010-00000005’
[2012-07-09 14:35:03] VERBOSE[16514] pbx.c: – Executing [h@from-internal:1] Hangup(“SIP/1010-00000005”, “”) in new stack
[2012-07-09 14:35:03] VERBOSE[16514] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/1010-00000005’
[2012-07-09 14:42:26] VERBOSE[2831] asterisk.c: – Remote UNIX connection
[2012-07-09 14:42:26] VERBOSE[16929] asterisk.c: – Remote UNIX connection disconnected
[2012-07-09 14:42:26] VERBOSE[2831] asterisk.c: – Remote UNIX connection
[2012-07-09 14:42:26] VERBOSE[16932] asterisk.c: – Remote UNIX connection disconnected
[2012-07-09 18:00:10] VERBOSE[2858] netsock2.c: == Using SIP RTP TOS bits 184
[2012-07-09 18:00:10] VERBOSE[2858] netsock2.c: == Using SIP RTP CoS mark 5
[2012-07-09 18:00:10] VERBOSE[19478] pbx.c: – Executing [1218555421121@from-internal:1] ResetCDR(“SIP/1010-00000006”, “”) in new stack
[2012-07-09 18:00:10] VERBOSE[19478] pbx.c: – Executing [1218555421121@from-internal:2] NoCDR(“SIP/1010-00000006”, “”) in new stack
[2012-07-09 18:00:10] VERBOSE[19478] pbx.c: – Executing [1218555421121@from-internal:3] Progress(“SIP/1010-00000006”, “”) in new stack
[2012-07-09 18:00:10] VERBOSE[19478] pbx.c: – Executing [1218555421121@from-internal:4] Wait(“SIP/1010-00000006”, “1”) in new stack
[2012-07-09 18:00:10] VERBOSE[19478] pbx.c: == Spawn extension (from-internal, 1218555421121, 4) exited non-zero on ‘SIP/1010-00000006’
[2012-07-09 18:00:10] VERBOSE[19478] pbx.c: – Executing [h@from-internal:1] Hangup(“SIP/1010-00000006”, “”) in new stack
[2012-07-09 18:00:10] VERBOSE[19478] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/1010-00000006’
[2012-07-09 18:00:15] VERBOSE[2858] netsock2.c: == Using SIP RTP TOS bits 184
[2012-07-09 18:00:15] VERBOSE[2858] netsock2.c: == Using SIP RTP CoS mark 5
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [2102184944@from-internal:1] Macro(“SIP/1010-00000007”, “user-callerid,LIMIT,”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/1010-00000007”, “AMPUSER=1010”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:2] GotoIf(“SIP/1010-00000007”, “0?report”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:3] ExecIf(“SIP/1010-00000007”, “1?Set(REALCALLERIDNUM=1010)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:4] Set(“SIP/1010-00000007”, “AMPUSER=1010”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/1010-00000007”, “AMPUSERCIDNAME=1010”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“SIP/1010-00000007”, “0?report”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:7] Set(“SIP/1010-00000007”, “AMPUSERCID=1010”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:8] Set(“SIP/1010-00000007”, “CALLERID(all)=“1010” <1010>”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:9] GotoIf(“SIP/1010-00000007”, “0?limit”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:10] ExecIf(“SIP/1010-00000007”, “1?Set(GROUP(concurrency_limit)=1010)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:11] GosubIf(“SIP/1010-00000007”, “0?sub-ccss,s,1(from-internal,2102184944)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:12] ExecIf(“SIP/1010-00000007”, “0?Set(CHANNEL(language)=)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:13] GotoIf(“SIP/1010-00000007”, “1?continue”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (macro-user-callerid,s,26)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:26] Set(“SIP/1010-00000007”, “CALLERID(number)=1010”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:27] Set(“SIP/1010-00000007”, “CALLERID(name)=1010”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-user-callerid:28] Set(“SIP/1010-00000007”, “CHANNEL(language)=en”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [2102184944@from-internal:2] Set(“SIP/1010-00000007”, “MOHCLASS=default”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [2102184944@from-internal:3] Set(“SIP/1010-00000007”, “_NODEST=”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [2102184944@from-internal:4] Gosub(“SIP/1010-00000007”, “sub-record-check,s,1(out,2102184944,)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“SIP/1010-00000007”, “1?check”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (sub-record-check,s,6)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:6] Set(“SIP/1010-00000007”, “__MON_FMT=wav”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:7] GotoIf(“SIP/1010-00000007”, “1?next”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (sub-record-check,s,10)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:10] ExecIf(“SIP/1010-00000007”, “0?Return()”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:11] GotoIf(“SIP/1010-00000007”, “0?out,1”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:12] Set(“SIP/1010-00000007”, “__REC_STATUS=INITIALIZED”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:13] ExecIf(“SIP/1010-00000007”, “0?Set(__REC_POLICY_MODE=)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:14] Set(“SIP/1010-00000007”, “NOW=1341874815”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:15] Set(“SIP/1010-00000007”, “__DAY=09”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:16] Set(“SIP/1010-00000007”, “__MONTH=07”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:17] Set(“SIP/1010-00000007”, “__YEAR=2012”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:18] Set(“SIP/1010-00000007”, “__TIMESTR=20120709-180015”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:19] Set(“SIP/1010-00000007”, “__FROMEXTEN=1010”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:20] Set(“SIP/1010-00000007”, “__CALLFILENAME=out-2102184944-1010-20120709-180015-1341874815.15”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-record-check:21] Goto(“SIP/1010-00000007”, “out,1”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (sub-record-check,out,1)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [out@sub-record-check:1] ExecIf(“SIP/1010-00000007”, “1?Set(__REC_POLICY_MODE=dontcare)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [out@sub-record-check:2] GosubIf(“SIP/1010-00000007”, “0?record,1(exten,2102184944,1010)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [out@sub-record-check:3] Return(“SIP/1010-00000007”, “”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [2102184944@from-internal:5] Macro(“SIP/1010-00000007”, “dialout-trunk,1,12102184944,”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:1] Set(“SIP/1010-00000007”, “DIAL_TRUNK=1”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:2] GosubIf(“SIP/1010-00000007”, “0?sub-pincheck,s,1()”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/1010-00000007”, “0?disabletrunk,1”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:4] Set(“SIP/1010-00000007”, “DIAL_NUMBER=12102184944”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:5] Set(“SIP/1010-00000007”, “DIAL_TRUNK_OPTIONS=tr”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:6] Set(“SIP/1010-00000007”, “OUTBOUND_GROUP=OUT_1”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/1010-00000007”, “1?nomax”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (macro-dialout-trunk,s,9)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/1010-00000007”, “0?skipoutcid”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:10] Set(“SIP/1010-00000007”, “DIAL_TRUNK_OPTIONS=”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:11] Macro(“SIP/1010-00000007”, “outbound-callerid,1”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outbound-callerid:1] ExecIf(“SIP/1010-00000007”, “0?Set(CALLERPRES()=)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outbound-callerid:2] ExecIf(“SIP/1010-00000007”, “0?Set(REALCALLERIDNUM=1010)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outbound-callerid:3] GotoIf(“SIP/1010-00000007”, “1?normcid”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (macro-outbound-callerid,s,6)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outbound-callerid:6] Set(“SIP/1010-00000007”, “USEROUTCID=”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outbound-callerid:7] Set(“SIP/1010-00000007”, “EMERGENCYCID=”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outbound-callerid:8] Set(“SIP/1010-00000007”, “TRUNKOUTCID=2102017015”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outbound-callerid:9] GotoIf(“SIP/1010-00000007”, “1?trunkcid”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (macro-outbound-callerid,s,12)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outbound-callerid:12] ExecIf(“SIP/1010-00000007”, “1?Set(CALLERID(all)=2102017015)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outbound-callerid:13] ExecIf(“SIP/1010-00000007”, “0?Set(CALLERID(all)=)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outbound-callerid:14] ExecIf(“SIP/1010-00000007”, “0?Set(CALLERID(all)=)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outbound-callerid:15] ExecIf(“SIP/1010-00000007”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:12] GosubIf(“SIP/1010-00000007”, “1?sub-flp-1,s,1()”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-flp-1:1] ExecIf(“SIP/1010-00000007”, “0?Set(TARGET_FLP_1=112102184944)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-flp-1:2] GotoIf(“SIP/1010-00000007”, “0?match”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@sub-flp-1:3] Return(“SIP/1010-00000007”, “”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:13] Set(“SIP/1010-00000007”, “OUTNUM=12102184944”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:14] Set(“SIP/1010-00000007”, “custom=AMP”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:15] ExecIf(“SIP/1010-00000007”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:16] ExecIf(“SIP/1010-00000007”, “0?Set(DIAL_TRUNK_OPTIONS=M(confirm))”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:17] Macro(“SIP/1010-00000007”, “dialout-trunk-predial-hook,”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/1010-00000007”, “”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/1010-00000007”, “0?bypass,1”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:19] ExecIf(“SIP/1010-00000007”, “1?Set(CONNECTEDLINE(num,i)=12102184944)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:20] ExecIf(“SIP/1010-00000007”, “1?Set(CONNECTEDLINE(name,i)=CID:2102017015)”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:21] GotoIf(“SIP/1010-00000007”, “1?customtrunk”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (macro-dialout-trunk,s,25)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:25] Set(“SIP/1010-00000007”, “pre_num=AMP:local/”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:26] Set(“SIP/1010-00000007”, “the_num=OUTNUM”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:27] Set(“SIP/1010-00000007”, “post_num=@googlevoice-robmorgan210gmailcom”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:28] GotoIf(“SIP/1010-00000007”, “1?outnum:skipoutnum”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (macro-dialout-trunk,s,29)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:29] Set(“SIP/1010-00000007”, “the_num=12102184944”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:30] Dial(“SIP/1010-00000007”, “local/12102184944@googlevoice-robmorgan210gmailcom,300,”) in new stack
[2012-07-09 18:00:15] NOTICE[19479] chan_local.c: No such extension/context 12102184944@googlevoice-robmorgan210gmailcom while calling Local channel
[2012-07-09 18:00:15] VERBOSE[19479] app_dial.c: – Couldn’t call local/12102184944@googlevoice-robmorgan210gmailcom
[2012-07-09 18:00:15] VERBOSE[19479] app_dial.c: == Everyone is busy/congested at this time (0:0/0/0)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:31] NoOp(“SIP/1010-00000007”, “Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 0”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-dialout-trunk:32] Goto(“SIP/1010-00000007”, “s-CHANUNAVAIL,1”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set(“SIP/1010-00000007”, “RC=0”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto(“SIP/1010-00000007”, “0,1”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (macro-dialout-trunk,0,1)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [0@macro-dialout-trunk:1] Goto(“SIP/1010-00000007”, “continue,1”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (macro-dialout-trunk,continue,1)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [continue@macro-dialout-trunk:1] GotoIf(“SIP/1010-00000007”, “1?noreport”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Goto (macro-dialout-trunk,continue,3)
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [continue@macro-dialout-trunk:3] NoOp(“SIP/1010-00000007”, “TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 0 - failing through to other trunks”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [continue@macro-dialout-trunk:4] Set(“SIP/1010-00000007”, “CALLERID(number)=1010”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [2102184944@from-internal:6] Macro(“SIP/1010-00000007”, “outisbusy,”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outisbusy:1] Progress(“SIP/1010-00000007”, “”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outisbusy:2] GotoIf(“SIP/1010-00000007”, “0?emergency,1”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outisbusy:3] GotoIf(“SIP/1010-00000007”, “0?intracompany,1”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] pbx.c: – Executing [s@macro-outisbusy:4] Playback(“SIP/1010-00000007”, “all-circuits-busy-now&pls-try-call-later, noanswer”) in new stack
[2012-07-09 18:00:15] VERBOSE[19479] file.c: – <SIP/1010-00000007> Playing ‘all-circuits-busy-now.gsm’ (language ‘en’)
[2012-07-09 18:00:17] VERBOSE[19479] file.c: – <SIP/1010-00000007> Playing ‘pls-try-call-later.gsm’ (language ‘en’)
[2012-07-09 18:00:18] VERBOSE[19479] app_macro.c: == Spawn extension (macro-outisbusy, s, 4) exited non-zero on ‘SIP/1010-00000007’ in macro ‘outisbusy’
[2012-07-09 18:00:18] VERBOSE[19479] pbx.c: == Spawn extension (from-internal, 2102184944, 6) exited non-zero on ‘SIP/1010-00000007’
[2012-07-09 18:00:18] VERBOSE[19479] pbx.c: – Executing [h@from-internal:1] Hangup(“SIP/1010-00000007”, “”) in new stack
[2012-07-09 18:00:18] VERBOSE[19479] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/1010-00000007’
[2012-07-09 18:00:22] VERBOSE[2858] netsock2.c: == Using SIP RTP TOS bits 184
[2012-07-09 18:00:22] VERBOSE[2858] netsock2.c: == Using SIP RTP CoS mark 5
[2012-07-09 18:00:22] VERBOSE[19480] pbx.c: – Executing [12102184944@from-internal:1] ResetCDR(“SIP/1010-00000008”, “”) in new stack
[2012-07-09 18:00:22] VERBOSE[19480] pbx.c: – Executing [12102184944@from-internal:2] NoCDR(“SIP/1010-00000008”, “”) in new stack
[2012-07-09 18:00:22] VERBOSE[19480] pbx.c: – Executing [12102184944@from-internal:3] Progress(“SIP/1010-00000008”, “”) in new stack
[2012-07-09 18:00:22] VERBOSE[19480] pbx.c: – Executing [12102184944@from-internal:4] Wait(“SIP/1010-00000008”, “1”) in new stack
[2012-07-09 18:00:23] VERBOSE[19480] pbx.c: – Executing [12102184944@from-internal:5] Progress(“SIP/1010-00000008”, “”) in new stack
[2012-07-09 18:00:23] VERBOSE[19480] pbx.c: – Executing [12102184944@from-internal:6] Playback(“SIP/1010-00000008”, “silence/1&cannot-complete-as-dialed&check-number-dial-again,noanswer”) in new stack
[2012-07-09 18:00:23] VERBOSE[19480] file.c: – <SIP/1010-00000008> Playing ‘silence/1.gsm’ (language ‘en’)
[2012-07-09 18:00:24] VERBOSE[19480] file.c: – <SIP/1010-00000008> Playing ‘cannot-complete-as-dialed.gsm’ (language ‘en’)
[2012-07-09 18:00:27] VERBOSE[19480] file.c: – <SIP/1010-00000008> Playing ‘check-number-dial-again.gsm’ (language ‘en’)
[2012-07-09 18:00:27] VERBOSE[19480] pbx.c: == Spawn extension (from-internal, 12102184944, 6) exited non-zero on ‘SIP/1010-00000008’
[2012-07-09 18:00:27] VERBOSE[19480] pbx.c: – Executing [h@from-internal:1] Hangup(“SIP/1010-00000008”, “”) in new stack
[2012-07-09 18:00:27] VERBOSE[19480] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/1010-00000008’
[2012-07-09 18:21:04] VERBOSE[2831] asterisk.c: – Remote UNIX connection
[2012-07-09 18:30:25] VERBOSE[2858] netsock2.c: == Using SIP RTP TOS bits 184
[2012-07-09 18:30:25] VERBOSE[2858] netsock2.c: == Using SIP RTP CoS mark 5
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [2102184944@from-internal:1] Macro(“SIP/1010-00000009”, “user-callerid,LIMIT,”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/1010-00000009”, “AMPUSER=1010”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:2] GotoIf(“SIP/1010-00000009”, “0?report”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:3] ExecIf(“SIP/1010-00000009”, “1?Set(REALCALLERIDNUM=1010)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:4] Set(“SIP/1010-00000009”, “AMPUSER=1010”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/1010-00000009”, “AMPUSERCIDNAME=1010”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“SIP/1010-00000009”, “0?report”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:7] Set(“SIP/1010-00000009”, “AMPUSERCID=1010”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:8] Set(“SIP/1010-00000009”, “CALLERID(all)=“1010” <1010>”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:9] GotoIf(“SIP/1010-00000009”, “0?limit”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:10] ExecIf(“SIP/1010-00000009”, “1?Set(GROUP(concurrency_limit)=1010)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:11] GosubIf(“SIP/1010-00000009”, “0?sub-ccss,s,1(from-internal,2102184944)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:12] ExecIf(“SIP/1010-00000009”, “0?Set(CHANNEL(language)=)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:13] GotoIf(“SIP/1010-00000009”, “1?continue”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (macro-user-callerid,s,26)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:26] Set(“SIP/1010-00000009”, “CALLERID(number)=1010”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:27] Set(“SIP/1010-00000009”, “CALLERID(name)=1010”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-user-callerid:28] Set(“SIP/1010-00000009”, “CHANNEL(language)=en”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [2102184944@from-internal:2] Set(“SIP/1010-00000009”, “MOHCLASS=default”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [2102184944@from-internal:3] Set(“SIP/1010-00000009”, “_NODEST=”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [2102184944@from-internal:4] Gosub(“SIP/1010-00000009”, “sub-record-check,s,1(out,2102184944,)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“SIP/1010-00000009”, “1?check”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (sub-record-check,s,6)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:6] Set(“SIP/1010-00000009”, “__MON_FMT=wav”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:7] GotoIf(“SIP/1010-00000009”, “1?next”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (sub-record-check,s,10)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:10] ExecIf(“SIP/1010-00000009”, “0?Return()”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:11] GotoIf(“SIP/1010-00000009”, “0?out,1”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:12] Set(“SIP/1010-00000009”, “__REC_STATUS=INITIALIZED”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:13] ExecIf(“SIP/1010-00000009”, “0?Set(__REC_POLICY_MODE=)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:14] Set(“SIP/1010-00000009”, “NOW=1341876625”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:15] Set(“SIP/1010-00000009”, “__DAY=09”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:16] Set(“SIP/1010-00000009”, “__MONTH=07”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:17] Set(“SIP/1010-00000009”, “__YEAR=2012”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:18] Set(“SIP/1010-00000009”, “__TIMESTR=20120709-183025”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:19] Set(“SIP/1010-00000009”, “__FROMEXTEN=1010”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:20] Set(“SIP/1010-00000009”, “__CALLFILENAME=out-2102184944-1010-20120709-183025-1341876625.19”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-record-check:21] Goto(“SIP/1010-00000009”, “out,1”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (sub-record-check,out,1)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [out@sub-record-check:1] ExecIf(“SIP/1010-00000009”, “1?Set(__REC_POLICY_MODE=dontcare)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [out@sub-record-check:2] GosubIf(“SIP/1010-00000009”, “0?record,1(exten,2102184944,1010)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [out@sub-record-check:3] Return(“SIP/1010-00000009”, “”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [2102184944@from-internal:5] Macro(“SIP/1010-00000009”, “dialout-trunk,1,12102184944,”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:1] Set(“SIP/1010-00000009”, “DIAL_TRUNK=1”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:2] GosubIf(“SIP/1010-00000009”, “0?sub-pincheck,s,1()”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/1010-00000009”, “0?disabletrunk,1”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:4] Set(“SIP/1010-00000009”, “DIAL_NUMBER=12102184944”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:5] Set(“SIP/1010-00000009”, “DIAL_TRUNK_OPTIONS=tr”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:6] Set(“SIP/1010-00000009”, “OUTBOUND_GROUP=OUT_1”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/1010-00000009”, “1?nomax”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (macro-dialout-trunk,s,9)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/1010-00000009”, “0?skipoutcid”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:10] Set(“SIP/1010-00000009”, “DIAL_TRUNK_OPTIONS=”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:11] Macro(“SIP/1010-00000009”, “outbound-callerid,1”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outbound-callerid:1] ExecIf(“SIP/1010-00000009”, “0?Set(CALLERPRES()=)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outbound-callerid:2] ExecIf(“SIP/1010-00000009”, “0?Set(REALCALLERIDNUM=1010)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outbound-callerid:3] GotoIf(“SIP/1010-00000009”, “1?normcid”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (macro-outbound-callerid,s,6)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outbound-callerid:6] Set(“SIP/1010-00000009”, “USEROUTCID=”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outbound-callerid:7] Set(“SIP/1010-00000009”, “EMERGENCYCID=”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outbound-callerid:8] Set(“SIP/1010-00000009”, “TRUNKOUTCID=2102017015”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outbound-callerid:9] GotoIf(“SIP/1010-00000009”, “1?trunkcid”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (macro-outbound-callerid,s,12)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outbound-callerid:12] ExecIf(“SIP/1010-00000009”, “1?Set(CALLERID(all)=2102017015)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outbound-callerid:13] ExecIf(“SIP/1010-00000009”, “0?Set(CALLERID(all)=)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outbound-callerid:14] ExecIf(“SIP/1010-00000009”, “0?Set(CALLERID(all)=)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outbound-callerid:15] ExecIf(“SIP/1010-00000009”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:12] GosubIf(“SIP/1010-00000009”, “1?sub-flp-1,s,1()”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-flp-1:1] ExecIf(“SIP/1010-00000009”, “0?Set(TARGET_FLP_1=112102184944)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-flp-1:2] GotoIf(“SIP/1010-00000009”, “0?match”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@sub-flp-1:3] Return(“SIP/1010-00000009”, “”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:13] Set(“SIP/1010-00000009”, “OUTNUM=12102184944”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:14] Set(“SIP/1010-00000009”, “custom=AMP”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:15] ExecIf(“SIP/1010-00000009”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:16] ExecIf(“SIP/1010-00000009”, “0?Set(DIAL_TRUNK_OPTIONS=M(confirm))”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:17] Macro(“SIP/1010-00000009”, “dialout-trunk-predial-hook,”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/1010-00000009”, “”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/1010-00000009”, “0?bypass,1”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:19] ExecIf(“SIP/1010-00000009”, “1?Set(CONNECTEDLINE(num,i)=12102184944)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:20] ExecIf(“SIP/1010-00000009”, “1?Set(CONNECTEDLINE(name,i)=CID:2102017015)”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:21] GotoIf(“SIP/1010-00000009”, “1?customtrunk”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (macro-dialout-trunk,s,25)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:25] Set(“SIP/1010-00000009”, “pre_num=AMP:local/”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:26] Set(“SIP/1010-00000009”, “the_num=OUTNUM”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:27] Set(“SIP/1010-00000009”, “post_num=@googlevoice-robmorgan210gmailcom”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:28] GotoIf(“SIP/1010-00000009”, “1?outnum:skipoutnum”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (macro-dialout-trunk,s,29)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:29] Set(“SIP/1010-00000009”, “the_num=12102184944”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:30] Dial(“SIP/1010-00000009”, “local/12102184944@googlevoice-robmorgan210gmailcom,300,”) in new stack
[2012-07-09 18:30:25] NOTICE[20132] chan_local.c: No such extension/context 12102184944@googlevoice-robmorgan210gmailcom while calling Local channel
[2012-07-09 18:30:25] VERBOSE[20132] app_dial.c: – Couldn’t call local/12102184944@googlevoice-robmorgan210gmailcom
[2012-07-09 18:30:25] VERBOSE[20132] app_dial.c: == Everyone is busy/congested at this time (0:0/0/0)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:31] NoOp(“SIP/1010-00000009”, “Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 0”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-dialout-trunk:32] Goto(“SIP/1010-00000009”, “s-CHANUNAVAIL,1”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set(“SIP/1010-00000009”, “RC=0”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto(“SIP/1010-00000009”, “0,1”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (macro-dialout-trunk,0,1)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [0@macro-dialout-trunk:1] Goto(“SIP/1010-00000009”, “continue,1”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (macro-dialout-trunk,continue,1)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [continue@macro-dialout-trunk:1] GotoIf(“SIP/1010-00000009”, “1?noreport”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Goto (macro-dialout-trunk,continue,3)
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [continue@macro-dialout-trunk:3] NoOp(“SIP/1010-00000009”, “TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 0 - failing through to other trunks”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [continue@macro-dialout-trunk:4] Set(“SIP/1010-00000009”, “CALLERID(number)=1010”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [2102184944@from-internal:6] Macro(“SIP/1010-00000009”, “outisbusy,”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outisbusy:1] Progress(“SIP/1010-00000009”, “”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outisbusy:2] GotoIf(“SIP/1010-00000009”, “0?emergency,1”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outisbusy:3] GotoIf(“SIP/1010-00000009”, “0?intracompany,1”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] pbx.c: – Executing [s@macro-outisbusy:4] Playback(“SIP/1010-00000009”, “all-circuits-busy-now&pls-try-call-later, noanswer”) in new stack
[2012-07-09 18:30:25] VERBOSE[20132] file.c: – <SIP/1010-00000009> Playing ‘all-circuits-busy-now.gsm’ (language ‘en’)
[2012-07-09 18:30:27] VERBOSE[20132] file.c: – <SIP/1010-00000009> Playing ‘pls-try-call-later.gsm’ (language ‘en’)
[2012-07-09 18:30:29] VERBOSE[20132] pbx.c: – Executing [s@macro-outisbusy:5] Congestion(“SIP/1010-00000009”, “20”) in new stack
[2012-07-09 18:30:29] VERBOSE[20132] app_macro.c: == Spawn extension (macro-outisbusy, s, 5) exited non-zero on ‘SIP/1010-00000009’ in macro ‘outisbusy’
[2012-07-09 18:30:29] VERBOSE[20132] pbx.c: == Spawn extension (from-internal, 2102184944, 6) exited non-zero on ‘SIP/1010-00000009’
[2012-07-09 18:30:29] VERBOSE[20132] pbx.c: – Executing [h@from-internal:1] Hangup(“SIP/1010-00000009”, “”) in new stack
[2012-07-09 18:30:29] VERBOSE[20132] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/1010-00000009’