[Mar 18 11:13:54]     -- Executing [0415494xxx@from-internal:1] Macro("SIP/200-086ebc18", "user-callerid|SKIPTTL|") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:1] NoOp("SIP/200-086ebc18", "user-callerid: device 200") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:2] Set("SIP/200-086ebc18", "AMPUSER=200") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:3] GotoIf("SIP/200-086ebc18", "0?report") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:4] ExecIf("SIP/200-086ebc18", "1|Set|REALCALLERIDNUM=200") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:5] NoOp("SIP/200-086ebc18", "REALCALLERIDNUM is 200") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:6] Set("SIP/200-086ebc18", "AMPUSER=200") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:7] Set("SIP/200-086ebc18", "AMPUSERCIDNAME=NIrving") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:8] GotoIf("SIP/200-086ebc18", "0?report") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:9] Set("SIP/200-086ebc18", "AMPUSERCID=200") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:10] Set("SIP/200-086ebc18", "CALLERID(all)="NIrving" <200>") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:11] Set("SIP/200-086ebc18", "REALCALLERIDNUM=200") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:12] ExecIf("SIP/200-086ebc18", "0|Set|CHANNEL(language)=") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:13] NoOp("SIP/200-086ebc18", "TTL:  ARG1: SKIPTTL") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:14] GotoIf("SIP/200-086ebc18", "1?continue") in new stack
[Mar 18 11:13:54]     -- Goto (macro-user-callerid,s,23)
[Mar 18 11:13:54]     -- Executing [s@macro-user-callerid:23] NoOp("SIP/200-086ebc18", "Using CallerID "NIrving" <200>") in new stack
[Mar 18 11:13:54]     -- Executing [0415494xxx@from-internal:2] Set("SIP/200-086ebc18", "_NODEST=") in new stack
[Mar 18 11:13:54]     -- Executing [0415494xxx@from-internal:3] Macro("SIP/200-086ebc18", "record-enable|200|OUT|") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-record-enable:1] GotoIf("SIP/200-086ebc18", "0?2:4") in new stack
[Mar 18 11:13:54]     -- Goto (macro-record-enable,s,4)
[Mar 18 11:13:54]     -- Executing [s@macro-record-enable:4] AGI("SIP/200-086ebc18", "recordingcheck|20080318-111354|1205799234.4") in new stack
[Mar 18 11:13:54]     -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
[Mar 18 11:13:54]   recordingcheck|20080318-111354|1205799234.4: Outbound recording not enabled
[Mar 18 11:13:54]     -- AGI Script recordingcheck completed, returning 0
[Mar 18 11:13:54]     -- Executing [s@macro-record-enable:5] NoOp("SIP/200-086ebc18", "No recording needed") in new stack
[Mar 18 11:13:54]     -- Executing [0415494xxx@from-internal:4] Macro("SIP/200-086ebc18", "dialout-trunk|2|0415494xxx||") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-dialout-trunk:1] Set("SIP/200-086ebc18", "DIAL_TRUNK=2") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-dialout-trunk:2] ExecIf("SIP/200-086ebc18", "0|Authenticate|") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/200-086ebc18", "0?disabletrunk|1") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-dialout-trunk:4] Set("SIP/200-086ebc18", "DIAL_NUMBER=0415494xxx") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-dialout-trunk:5] Set("SIP/200-086ebc18", "DIAL_TRUNK_OPTIONS=tr") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-dialout-trunk:6] Set("SIP/200-086ebc18", "GROUP()=OUT_2") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/200-086ebc18", "1?nomax") in new stack
[Mar 18 11:13:54]     -- Goto (macro-dialout-trunk,s,9)
[Mar 18 11:13:54]     -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/200-086ebc18", "0?skipoutcid") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-dialout-trunk:10] Set("SIP/200-086ebc18", "DIAL_TRUNK_OPTIONS=") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-dialout-trunk:11] Macro("SIP/200-086ebc18", "outbound-callerid|2") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-outbound-callerid:1] GotoIf("SIP/200-086ebc18", "1?start") in new stack
[Mar 18 11:13:54]     -- Goto (macro-outbound-callerid,s,3)
[Mar 18 11:13:54]     -- Executing [s@macro-outbound-callerid:3] NoOp("SIP/200-086ebc18", "REALCALLERIDNUM is 200") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-outbound-callerid:4] GotoIf("SIP/200-086ebc18", "1?normcid") in new stack
[Mar 18 11:13:54]     -- Goto (macro-outbound-callerid,s,9)
[Mar 18 11:13:54]     -- Executing [s@macro-outbound-callerid:9] Set("SIP/200-086ebc18", "USEROUTCID=") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-outbound-callerid:10] Set("SIP/200-086ebc18", "EMERGENCYCID=") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-outbound-callerid:11] Set("SIP/200-086ebc18", "TRUNKOUTCID=") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-outbound-callerid:12] GotoIf("SIP/200-086ebc18", "1?trunkcid") in new stack
[Mar 18 11:13:54]     -- Goto (macro-outbound-callerid,s,16)
[Mar 18 11:13:54]     -- Executing [s@macro-outbound-callerid:16] GotoIf("SIP/200-086ebc18", "1?usercid") in new stack
[Mar 18 11:13:54]     -- Goto (macro-outbound-callerid,s,18)
[Mar 18 11:13:54]     -- Executing [s@macro-outbound-callerid:18] GotoIf("SIP/200-086ebc18", "1?report") in new stack
[Mar 18 11:13:54]     -- Goto (macro-outbound-callerid,s,22)
[Mar 18 11:13:54]     -- Executing [s@macro-outbound-callerid:22] NoOp("SIP/200-086ebc18", "CallerID set to "NIrving" <200>") in new stack
[Mar 18 11:13:54]     -- Executing [s@macro-dialout-trunk:12] AGI("SIP/200-086ebc18", "fixlocalprefix") in new stack
[Mar 18 11:13:54]     -- Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
[Mar 18 11:13:55]        >  fixlocalprefix: Using pattern 771
[Mar 18 11:13:55]        >  fixlocalprefix: Using pattern 777
[Mar 18 11:13:55]        >  fixlocalprefix: Using pattern 775
[Mar 18 11:13:55]        >  fixlocalprefix: Using pattern 61+1800XXXXXX
[Mar 18 11:13:55]        >  fixlocalprefix: Using pattern 03+5XXXXXXX
[Mar 18 11:13:55]        >  fixlocalprefix: Using pattern 03+6XXXXXXX
[Mar 18 11:13:55]        >  fixlocalprefix: Using pattern 03+8XXXXXXX
[Mar 18 11:13:55]        >  fixlocalprefix: Using pattern 03+9XXXXXXX
[Mar 18 11:13:55]        >  fixlocalprefix: Using pattern 0+NXXXXXXXX
[Mar 18 11:13:55]        >  fixlocalprefix: Using pattern 0011+ZXXXXXXXXX.
[Mar 18 11:13:55]     -- AGI Script fixlocalprefix completed, returning 0
[Mar 18 11:13:55]     -- Executing [s@macro-dialout-trunk:13] Set("SIP/200-086ebc18", "OUTNUM=0415494xxx") in new stack
[Mar 18 11:13:55]     -- Executing [s@macro-dialout-trunk:14] Set("SIP/200-086ebc18", "custom=SIP/pennytelsip") in new stack
[Mar 18 11:13:55]     -- Executing [s@macro-dialout-trunk:15] GotoIf("SIP/200-086ebc18", "1?gocall") in new stack
[Mar 18 11:13:55]     -- Goto (macro-dialout-trunk,s,17)
[Mar 18 11:13:55]     -- Executing [s@macro-dialout-trunk:17] Macro("SIP/200-086ebc18", "dialout-trunk-predial-hook|") in new stack
[Mar 18 11:13:55]     -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/200-086ebc18", "0?bypass|1") in new stack
[Mar 18 11:13:55]     -- Executing [s@macro-dialout-trunk:19] GotoIf("SIP/200-086ebc18", "0?customtrunk") in new stack
[Mar 18 11:13:55]     -- Executing [s@macro-dialout-trunk:20] Dial("SIP/200-086ebc18", "SIP/pennytelsip/0415494xxx|300|") in new stack
[Mar 18 11:13:55]     -- Called pennytelsip/0415494xxx
[Mar 18 11:14:23]     -- SIP/pennytelsip-086ed1a8 is making progress passing it to SIP/200-086ebc18
[Mar 18 11:14:27]   == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on 'SIP/200-086ebc18' in macro 'dialout-trunk'
[Mar 18 11:14:27]   == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on 'SIP/200-086ebc18'
[Mar 18 11:14:27]     -- Executing [h@macro-dialout-trunk:1] Macro("SIP/200-086ebc18", "hangupcall|") in new stack
[Mar 18 11:14:27]     -- Executing [s@macro-hangupcall:1] ResetCDR("SIP/200-086ebc18", "w") in new stack
[Mar 18 11:14:27]     -- Executing [s@macro-hangupcall:2] NoCDR("SIP/200-086ebc18", "") in new stack
[Mar 18 11:14:27]     -- Executing [s@macro-hangupcall:3] GotoIf("SIP/200-086ebc18", "1?skiprg") in new stack
[Mar 18 11:14:27]     -- Goto (macro-hangupcall,s,6)
[Mar 18 11:14:27]     -- Executing [s@macro-hangupcall:6] GotoIf("SIP/200-086ebc18", "1?skipblkvm") in new stack
[Mar 18 11:14:27]     -- Goto (macro-hangupcall,s,9)
[Mar 18 11:14:27]     -- Executing [s@macro-hangupcall:9] GotoIf("SIP/200-086ebc18", "1?theend") in new stack
[Mar 18 11:14:27]     -- Goto (macro-hangupcall,s,11)
[Mar 18 11:14:27]     -- Executing [s@macro-hangupcall:11] Hangup("SIP/200-086ebc18", "") in new stack
[Mar 18 11:14:27]   == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/200-086ebc18' in macro 'hangupcall'
[Mar 18 11:14:27]   == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/200-086ebc18'