[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("SIP/700-000000f2", "DIAL_TRUNK=1") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/700-000000f2", "0?sub-pincheck,s,1()") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/700-000000f2", "0?disabletrunk,1") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("SIP/700-000000f2", "DIAL_NUMBER=numberdialed") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("SIP/700-000000f2", "DIAL_TRUNK_OPTIONS=tr") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("SIP/700-000000f2", "OUTBOUND_GROUP=OUT_1") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/700-000000f2", "0?nomax") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:8] GotoIf("SIP/700-000000f2", "0?chanfull") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/700-000000f2", "0?skipoutcid") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("SIP/700-000000f2", "DIAL_TRUNK_OPTIONS=") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("SIP/700-000000f2", "outbound-callerid,1") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("SIP/700-000000f2", "0?Set(CALLERPRES()=)") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("SIP/700-000000f2", "0?Set(REALCALLERIDNUM=700)") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("SIP/700-000000f2", "1?normcid") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Goto (macro-outbound-callerid,s,6)
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("SIP/700-000000f2", "USEROUTCID=") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("SIP/700-000000f2", "EMERGENCYCID=") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("SIP/700-000000f2", "TRUNKOUTCID=") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("SIP/700-000000f2", "1?trunkcid") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Goto (macro-outbound-callerid,s,12)
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("SIP/700-000000f2", "0?Set(CALLERID(all)=)") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("SIP/700-000000f2", "0?Set(CALLERID(all)=)") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/700-000000f2", "1?Set(CALLERID(all)=pstncallerid)") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("SIP/700-000000f2", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("SIP/700-000000f2", "0?sub-flp-1,s,1()") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("SIP/700-000000f2", "OUTNUM=numberdialed") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("SIP/700-000000f2", "custom=DAHDI/1") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/700-000000f2", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:16] ExecIf("SIP/700-000000f2", "0?Set(DIAL_TRUNK_OPTIONS=M(confirm))") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:17] Macro("SIP/700-000000f2", "dialout-trunk-predial-hook,") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/700-000000f2", "") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/700-000000f2", "0?bypass,1") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:19] ExecIf("SIP/700-000000f2", "1?Set(CONNECTEDLINE(num,i)=numberdialed)") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:20] ExecIf("SIP/700-000000f2", "1?Set(CONNECTEDLINE(name,i)=CID:pstncallerid)") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:21] GotoIf("SIP/700-000000f2", "0?customtrunk") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:22] Dial("SIP/700-000000f2", "DAHDI/1/numberdialed,300,") in new stack
[2013-06-06 11:54:40] WARNING[11868] app_dial.c: Unable to create channel of type 'DAHDI' (cause 17 - User busy)
[2013-06-06 11:54:40] VERBOSE[11868] app_dial.c: == Everyone is busy/congested at this time (1:1/0/0)
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:23] NoOp("SIP/700-000000f2", "Dial failed for some reason with DIALSTATUS = BUSY and HANGUPCAUSE = 17") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s@macro-dialout-trunk:24] Goto("SIP/700-000000f2", "s-BUSY,1") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Goto (macro-dialout-trunk,s-BUSY,1)
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s-BUSY@macro-dialout-trunk:1] NoOp("SIP/700-000000f2", "Dial failed due to trunk reporting BUSY - giving up") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s-BUSY@macro-dialout-trunk:2] PlayTones("SIP/700-000000f2", "busy") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [s-BUSY@macro-dialout-trunk:3] Busy("SIP/700-000000f2", "20") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] app_macro.c: == Spawn extension (macro-dialout-trunk, s-BUSY, 3) exited non-zero on 'SIP/700-000000f2' in macro 'dialout-trunk'
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: == Spawn extension (from-internal, numberdialed, 6) exited non-zero on 'SIP/700-000000f2'
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: -- Executing [h@from-internal:1] Hangup("SIP/700-000000f2", "") in new stack
[2013-06-06 11:54:40] VERBOSE[11868] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/700-000000f2'
[2013-06-06 11:54:44] NOTICE[2229] chan_sip.c: Peer 'voipms' is now Reachable. (54ms / 2000ms)
[2013-06-06 11:54:47] VERBOSE[11863] pbx.c: -- Executing [h@macro-dialout-trunk:1] Macro("DAHDI/1-1", "hangupcall,") in new stack
[2013-06-06 11:54:47] VERBOSE[11863] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("DAHDI/1-1", "1?theend") in new stack
[2013-06-06 11:54:47] VERBOSE[11863] pbx.c: -- Goto (macro-hangupcall,s,3)
[2013-06-06 11:54:47] VERBOSE[11863] pbx.c: -- Executing [s@macro-hangupcall:3] ExecIf("DAHDI/1-1", "0?Set(CDR(recordingfile)=)") in new stack
[2013-06-06 11:54:47] VERBOSE[11863] pbx.c: -- Executing [s@macro-hangupcall:4] Hangup("DAHDI/1-1", "") in new stack
[2013-06-06 11:54:47] VERBOSE[11863] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'DAHDI/1-1' in macro 'hangupcall'
[2013-06-06 11:54:47] VERBOSE[11863] features.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'DAHDI/1-1'
[2013-06-06 11:54:47] VERBOSE[11863] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 22) exited non-zero on 'DAHDI/1-1' in macro 'dialout-trunk'
[2013-06-06 11:54:47] VERBOSE[11863] pbx.c: == Spawn extension (from-internal, 253cellphonecallsgetransferredto, 5) exited non-zero on 'DAHDI/1-1'
[2013-06-06 11:54:47] VERBOSE[11863] sig_analog.c: -- Hanging up on 'DAHDI/1-1'
[2013-06-06 11:54:47] VERBOSE[11863] chan_dahdi.c: -- Hungup 'DAHDI/1-1'