[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [9029925045@Call01:1] Goto(“SIP/7134-b73f0088”, “Call01_rulematch|9029925045|1”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Goto (Call01_rulematch,9029925045,1)
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [9029925045@Call01_rulematch:1] Macro(“SIP/7134-b73f0088”, “user-callerid|SKIPTTL|”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:1] NoOp(“SIP/7134-b73f0088”, “user-callerid: device 7134”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Noop
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:2] Set(“SIP/7134-b73f0088”, “AMPUSER=7134”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:3] GotoIf(“SIP/7134-b73f0088”, “0?report”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:4] ExecIf(“SIP/7134-b73f0088”, “1|Set|REALCALLERIDNUM=7134”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: ExecIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:5] NoOp(“SIP/7134-b73f0088”, “REALCALLERIDNUM is 7134”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Noop
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:6] Set(“SIP/7134-b73f0088”, “AMPUSER=7134”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:7] Set(“SIP/7134-b73f0088”, “AMPUSERCIDNAME=Suntaree Asavayouth”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:8] GotoIf(“SIP/7134-b73f0088”, “0?report”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:9] Set(“SIP/7134-b73f0088”, “AMPUSERCID=7134”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:10] Set(“SIP/7134-b73f0088”, “CALLERID(all)=“Suntaree Asavayouth” <7134>”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:11] Set(“SIP/7134-b73f0088”, “REALCALLERIDNUM=7134”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] DEBUG[24497] func_db.c: DB: AMPUSER/7134/language not found in database.
[Oct 12 10:36:23] DEBUG[24497] func_db.c: DB: AMPUSER/7134/language not found in database.
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:12] ExecIf(“SIP/7134-b73f0088”, “0|Set|CHANNEL(language)=”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: ExecIf
[Oct 12 10:36:23] DEBUG[24497] func_db.c: DB: AMPUSER/7134/language not found in database.
[Oct 12 10:36:23] DEBUG[24497] func_db.c: DB: AMPUSER/7134/language not found in database.
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:13] NoOp(“SIP/7134-b73f0088”, “TTL: ARG1: SKIPTTL”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Noop
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:14] GotoIf(“SIP/7134-b73f0088”, “1?continue”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Goto (macro-user-callerid,s,23)
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-user-callerid:23] NoOp(“SIP/7134-b73f0088”, “Using CallerID “Suntaree Asavayouth” <7134>”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Noop
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [9029925045@Call01_rulematch:2] Set(“SIP/7134-b73f0088”, “_NODEST=”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [9029925045@Call01_rulematch:3] Macro(“SIP/7134-b73f0088”, “record-enable|7134|OUT|”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-record-enable:1] GotoIf(“SIP/7134-b73f0088”, “0?2:4”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Goto (macro-record-enable,s,4)
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-record-enable:4] AGI(“SIP/7134-b73f0088”, “recordingcheck|20091012-103623|1255318583.1574”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
[Oct 12 10:36:23] VERBOSE[24497] logger.c: recordingcheck|20091012-103623|1255318583.1574: Outbound recording not enabled
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – AGI Script recordingcheck completed, returning 0
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: AGI
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-record-enable:5] NoOp(“SIP/7134-b73f0088”, “No recording needed”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Noop
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [9029925045@Call01_rulematch:4] Macro(“SIP/7134-b73f0088”, “dialout-trunk|1|029925045||”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:1] Set(“SIP/7134-b73f0088”, “DIAL_TRUNK=1”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] DEBUG[24497] func_db.c: DB: AMPUSER/7134/pinless not found in database.
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:2] ExecIf(“SIP/7134-b73f0088”, “0|Authenticate|”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: ExecIf
[Oct 12 10:36:23] DEBUG[24497] func_db.c: DB: AMPUSER/7134/pinless not found in database.
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/7134-b73f0088”, “0?disabletrunk|1”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:4] Set(“SIP/7134-b73f0088”, “DIAL_NUMBER=029925045”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:5] Set(“SIP/7134-b73f0088”, “DIAL_TRUNK_OPTIONS=tTwW”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:6] Set(“SIP/7134-b73f0088”, “GROUP()=OUT_1”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/7134-b73f0088”, “0?nomax”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:8] GotoIf(“SIP/7134-b73f0088”, “0?chanfull”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/7134-b73f0088”, “0?skipoutcid”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:10] Set(“SIP/7134-b73f0088”, “DIAL_TRUNK_OPTIONS=tTW”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:11] Macro(“SIP/7134-b73f0088”, “outbound-callerid|1”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:1] GotoIf(“SIP/7134-b73f0088”, “1?start”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Goto (macro-outbound-callerid,s,3)
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:3] NoOp(“SIP/7134-b73f0088”, “REALCALLERIDNUM is 7134”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Noop
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:4] GotoIf(“SIP/7134-b73f0088”, “1?normcid”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Goto (macro-outbound-callerid,s,9)
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:9] Set(“SIP/7134-b73f0088”, “USEROUTCID=21007134”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] DEBUG[24497] func_db.c: DB: DEVICE/7134/emergency_cid not found in database.
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:10] Set(“SIP/7134-b73f0088”, “EMERGENCYCID=”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:11] Set(“SIP/7134-b73f0088”, “TRUNKOUTCID=21007100”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:12] GotoIf(“SIP/7134-b73f0088”, “1?trunkcid”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Goto (macro-outbound-callerid,s,16)
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:16] GotoIf(“SIP/7134-b73f0088”, “0?usercid”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:17] Set(“SIP/7134-b73f0088”, “CALLERID(all)=21007100”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:18] GotoIf(“SIP/7134-b73f0088”, “0?report”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:19] Set(“SIP/7134-b73f0088”, “CALLERID(all)=21007134”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:20] GotoIf(“SIP/7134-b73f0088”, “1?report:hidecid”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Goto (macro-outbound-callerid,s,22)
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-outbound-callerid:22] NoOp(“SIP/7134-b73f0088”, “CallerID set to “” <21007134>”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Noop
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Macro
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:12] AGI(“SIP/7134-b73f0088”, “fixlocalprefix”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – AGI Script fixlocalprefix completed, returning 0
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: AGI
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:13] Set(“SIP/7134-b73f0088”, “OUTNUM=029925045”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:14] Set(“SIP/7134-b73f0088”, “custom=ZAP/g1”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Set
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:15] GotoIf(“SIP/7134-b73f0088”, “1?gocall”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Goto (macro-dialout-trunk,s,17)
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:17] Macro(“SIP/7134-b73f0088”, “dialout-trunk-predial-hook|”) in new stack
[Oct 12 10:36:23] WARNING[24497] app_macro.c: Context ‘macro-dialout-trunk-predial-hook’ for macro ‘dialout-trunk-predial-hook’ lacks ‘s’ extension, priority 1
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: Macro
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/7134-b73f0088”, “0?bypass|1”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:19] GotoIf(“SIP/7134-b73f0088”, “0?customtrunk”) in new stack
[Oct 12 10:36:23] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Executing [s@macro-dialout-trunk:20] Dial(“SIP/7134-b73f0088”, “ZAP/g1/029925045|300|tTW”) in new stack
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Requested transfer capability: 0x00 - SPEECH
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Called g1/029925045
[Oct 12 10:36:23] VERBOSE[24497] logger.c: – Zap/1-1 is proceeding passing it to SIP/7134-b73f0088
[Oct 12 10:36:24] VERBOSE[24497] logger.c: – Zap/1-1 is ringing
[Oct 12 10:36:25] VERBOSE[24497] logger.c: – Zap/1-1 answered SIP/7134-b73f0088
[Oct 12 10:36:29] DEBUG[24497] chan_zap.c: Started VLDTMF digit ‘1’
[Oct 12 10:36:29] DEBUG[24497] chan_zap.c: Ending VLDTMF digit ‘1’
[Oct 12 10:36:29] DEBUG[24497] chan_zap.c: Started VLDTMF digit ‘2’
[Oct 12 10:36:29] DEBUG[24497] chan_zap.c: Ending VLDTMF digit ‘2’
[Oct 12 10:36:29] DEBUG[24497] chan_zap.c: Started VLDTMF digit ‘4’
[Oct 12 10:36:29] DEBUG[24497] chan_zap.c: Ending VLDTMF digit ‘4’
[Oct 12 10:37:32] ERROR[24497] chan_zap.c: Write to 130 failed: Unknown error 500
[Oct 12 10:37:32] ERROR[24497] chan_zap.c: Short write: 0/15 (Unknown error 500)
[Oct 12 10:37:32] WARNING[24497] chan_zap.c: Detected alarm on channel 1: Yellow Alarm
[Oct 12 10:37:32] DEBUG[24497] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/1-1
[Oct 12 10:37:32] DEBUG[24497] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/1-1
[Oct 12 10:37:32] VERBOSE[24497] logger.c: – Hungup ‘Zap/1-1’
[Oct 12 10:37:32] VERBOSE[24497] logger.c: == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on ‘SIP/7134-b73f0088’ in macro ‘dialout-trunk’
[Oct 12 10:37:32] VERBOSE[24497] logger.c: == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on ‘SIP/7134-b73f0088’
[Oct 12 10:37:32] VERBOSE[24497] logger.c: – Executing [h@macro-dialout-trunk:1] Macro(“SIP/7134-b73f0088”, “hangupcall|”) in new stack
[Oct 12 10:37:32] VERBOSE[24497] logger.c: – Executing [s@macro-hangupcall:1] ResetCDR(“SIP/7134-b73f0088”, “w”) in new stack
[Oct 12 10:37:32] DEBUG[24497] app_macro.c: Executed application: ResetCDR
[Oct 12 10:37:32] VERBOSE[24497] logger.c: – Executing [s@macro-hangupcall:2] NoCDR(“SIP/7134-b73f0088”, “”) in new stack
[Oct 12 10:37:32] DEBUG[24497] app_macro.c: Executed application: NoCDR
[Oct 12 10:37:32] VERBOSE[24497] logger.c: – Executing [s@macro-hangupcall:3] GotoIf(“SIP/7134-b73f0088”, “1?skiprg”) in new stack
[Oct 12 10:37:32] VERBOSE[24497] logger.c: – Goto (macro-hangupcall,s,6)
[Oct 12 10:37:32] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:37:32] VERBOSE[24497] logger.c: – Executing [s@macro-hangupcall:6] GotoIf(“SIP/7134-b73f0088”, “1?skipblkvm”) in new stack
[Oct 12 10:37:32] VERBOSE[24497] logger.c: – Goto (macro-hangupcall,s,9)
[Oct 12 10:37:32] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:37:32] VERBOSE[24497] logger.c: – Executing [s@macro-hangupcall:9] GotoIf(“SIP/7134-b73f0088”, “1?theend”) in new stack
[Oct 12 10:37:32] VERBOSE[24497] logger.c: – Goto (macro-hangupcall,s,11)
[Oct 12 10:37:32] DEBUG[24497] app_macro.c: Executed application: GotoIf
[Oct 12 10:37:32] VERBOSE[24497] logger.c: – Executing [s@macro-hangupcall:11] Hangup(“SIP/7134-b73f0088”, “”) in new stack
[Oct 12 10:37:32] VERBOSE[24497] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘SIP/7134-b73f0088’ in macro ‘hangupcall’
[Oct 12 10:37:32] VERBOSE[24497] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘SIP/7134-b73f0088’