rendered paste body[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [15163205516@from-internal:1] Set("SIP/1000-09a3cfc8", "EMERGENCYROUTE=YES") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [15163205516@from-internal:2] Macro("SIP/1000-09a3cfc8", "dialout-trunk|2|15163205516||") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:1] Set("SIP/1000-09a3cfc8", "DIAL_TRUNK=2") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:2] Set("SIP/1000-09a3cfc8", "DIAL_NUMBER=15163205516") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:3] Set("SIP/1000-09a3cfc8", "ROUTE_PASSWD=") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:4] GotoIf("SIP/1000-09a3cfc8", "1?noauth") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Goto (macro-dialout-trunk,s,6)
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:6] GotoIf("SIP/1000-09a3cfc8", "0?disabletrunk|1") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:7] Set("SIP/1000-09a3cfc8", "_NODEST=") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:8] Set("SIP/1000-09a3cfc8", "DIAL_TRUNK_OPTIONS=tr") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:9] Set("SIP/1000-09a3cfc8", "GROUP()=OUT_2") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:10] Macro("SIP/1000-09a3cfc8", "user-callerid|SKIPTTL") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:1] NoOp("SIP/1000-09a3cfc8", "user-callerid: device 1000") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Noop
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:2] Set("SIP/1000-09a3cfc8", "AMPUSER=1000") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:3] GotoIf("SIP/1000-09a3cfc8", "0?report") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:4] GotoIf("SIP/1000-09a3cfc8", "0?start") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:5] Set("SIP/1000-09a3cfc8", "REALCALLERIDNUM=1000") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:6] NoOp("SIP/1000-09a3cfc8", "REALCALLERIDNUM is 1000") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: NoOp
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:7] Set("SIP/1000-09a3cfc8", "AMPUSER=1000") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:8] Set("SIP/1000-09a3cfc8", "AMPUSERCIDNAME=Demo 1") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:9] GotoIf("SIP/1000-09a3cfc8", "0?report") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:10] Set("SIP/1000-09a3cfc8", "AMPUSERCID=1000") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:11] Set("SIP/1000-09a3cfc8", "CALLERID(all)="Demo 1" <1000>") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:12] Set("SIP/1000-09a3cfc8", "REALCALLERIDNUM=1000") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:13] NoOp("SIP/1000-09a3cfc8", "TTL: ARG1: SKIPTTL") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Noop
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:14] GotoIf("SIP/1000-09a3cfc8", "1?continue") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Goto (macro-user-callerid,s,23)
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-user-callerid:23] NoOp("SIP/1000-09a3cfc8", "Using CallerID "Demo 1" <1000>") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: NoOp
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Macro
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:11] Macro("SIP/1000-09a3cfc8", "record-enable|1000|OUT") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-record-enable:1] GotoIf("SIP/1000-09a3cfc8", "0?2:4") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Goto (macro-record-enable,s,4)
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-record-enable:4] AGI("SIP/1000-09a3cfc8", "recordingcheck|20080216-141542|1203189342.8") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
[Feb 16 14:15:42] VERBOSE[4972] logger.c: recordingcheck|20080216-141542|1203189342.8: Outbound recording not enabled
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- AGI Script recordingcheck completed, returning 0
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: AGI
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-record-enable:5] NoOp("SIP/1000-09a3cfc8", "No recording needed") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Noop
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Macro
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:12] GotoIf("SIP/1000-09a3cfc8", "0?skipoutcid") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:13] Set("SIP/1000-09a3cfc8", "DIAL_TRUNK_OPTIONS=") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:14] Macro("SIP/1000-09a3cfc8", "outbound-callerid|2") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-outbound-callerid:1] GotoIf("SIP/1000-09a3cfc8", "1?start") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Goto (macro-outbound-callerid,s,3)
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-outbound-callerid:3] NoOp("SIP/1000-09a3cfc8", "REALCALLERIDNUM is 1000") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: NoOp
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-outbound-callerid:4] GotoIf("SIP/1000-09a3cfc8", "1?normcid") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Goto (macro-outbound-callerid,s,9)
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-outbound-callerid:9] Set("SIP/1000-09a3cfc8", "USEROUTCID=") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] DEBUG[4972] func_db.c: DB: DEVICE/1000/emergency_cid not found in database.
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-outbound-callerid:10] Set("SIP/1000-09a3cfc8", "EMERGENCYCID=") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-outbound-callerid:11] Set("SIP/1000-09a3cfc8", "TRUNKOUTCID=") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-outbound-callerid:12] GotoIf("SIP/1000-09a3cfc8", "0?trunkcid") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-outbound-callerid:13] GotoIf("SIP/1000-09a3cfc8", "1?trunkcid") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Goto (macro-outbound-callerid,s,16)
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-outbound-callerid:16] GotoIf("SIP/1000-09a3cfc8", "1?usercid") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Goto (macro-outbound-callerid,s,18)
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-outbound-callerid:18] GotoIf("SIP/1000-09a3cfc8", "1?report") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Goto (macro-outbound-callerid,s,22)
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-outbound-callerid:22] NoOp("SIP/1000-09a3cfc8", "CallerID set to "Demo 1" <1000>") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: NoOp
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Macro
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:15] GotoIf("SIP/1000-09a3cfc8", "1?nomax") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Goto (macro-dialout-trunk,s,17)
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:17] AGI("SIP/1000-09a3cfc8", "fixlocalprefix") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- AGI Script fixlocalprefix completed, returning 0
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: AGI
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:18] Set("SIP/1000-09a3cfc8", "OUTNUM=15163205516") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:19] Set("SIP/1000-09a3cfc8", "custom=ZAP/g0") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: Set
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:20] GotoIf("SIP/1000-09a3cfc8", "1?gocall") in new stack
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Goto (macro-dialout-trunk,s,24)
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:24] GotoIf("SIP/1000-09a3cfc8", "0?customtrunk") in new stack
[Feb 16 14:15:42] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Executing [s@macro-dialout-trunk:25] Dial("SIP/1000-09a3cfc8", "ZAP/g0/15163205516|300|") in new stack
[Feb 16 14:15:42] DEBUG[4972] chan_zap.c: Dialing '15163205516'
[Feb 16 14:15:42] DEBUG[4972] chan_zap.c: Deferring dialing...
[Feb 16 14:15:42] VERBOSE[4972] logger.c: -- Called g0/15163205516
[Feb 16 14:15:46] VERBOSE[4972] logger.c: -- Zap/1-1 answered SIP/1000-09a3cfc8
[Feb 16 14:15:52] VERBOSE[4972] logger.c: -- Hungup 'Zap/1-1'
[Feb 16 14:15:52] VERBOSE[4972] logger.c: == Spawn extension (macro-dialout-trunk, s, 25) exited non-zero on 'SIP/1000-09a3cfc8' in macro 'dialout-trunk'
[Feb 16 14:15:52] VERBOSE[4972] logger.c: == Spawn extension (macro-dialout-trunk, s, 25) exited non-zero on 'SIP/1000-09a3cfc8'
[Feb 16 14:15:52] VERBOSE[4972] logger.c: -- Executing [h@macro-dialout-trunk:1] Macro("SIP/1000-09a3cfc8", "hangupcall") in new stack
[Feb 16 14:15:52] VERBOSE[4972] logger.c: -- Executing [s@macro-hangupcall:1] ResetCDR("SIP/1000-09a3cfc8", "w") in new stack
[Feb 16 14:15:52] DEBUG[4972] app_macro.c: Executed application: ResetCDR
[Feb 16 14:15:52] VERBOSE[4972] logger.c: -- Executing [s@macro-hangupcall:2] NoCDR("SIP/1000-09a3cfc8", "") in new stack
[Feb 16 14:15:52] DEBUG[4972] app_macro.c: Executed application: NoCDR
[Feb 16 14:15:52] VERBOSE[4972] logger.c: -- Executing [s@macro-hangupcall:3] GotoIf("SIP/1000-09a3cfc8", "1?skiprg") in new stack
[Feb 16 14:15:52] VERBOSE[4972] logger.c: -- Goto (macro-hangupcall,s,6)
[Feb 16 14:15:52] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:52] VERBOSE[4972] logger.c: -- Executing [s@macro-hangupcall:6] GotoIf("SIP/1000-09a3cfc8", "1?skipblkvm") in new stack
[Feb 16 14:15:52] VERBOSE[4972] logger.c: -- Goto (macro-hangupcall,s,9)
[Feb 16 14:15:52] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:52] VERBOSE[4972] logger.c: -- Executing [s@macro-hangupcall:9] GotoIf("SIP/1000-09a3cfc8", "1?theend") in new stack
[Feb 16 14:15:52] VERBOSE[4972] logger.c: -- Goto (macro-hangupcall,s,11)
[Feb 16 14:15:52] DEBUG[4972] app_macro.c: Executed application: GotoIf
[Feb 16 14:15:52] VERBOSE[4972] logger.c: -- Executing [s@macro-hangupcall:11] Hangup("SIP/1000-09a3cfc8", "") in new stack
[Feb 16 14:15:52] VERBOSE[4972] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/1000-09a3cfc8' in macro 'hangupcall'
[Feb 16 14:15:52] VERBOSE[4972] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/1000-09a3cfc8'