[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:1] Macro("SIP/300-00002cdd", "user-callerid,LIMIT,EXTERNAL,") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:1] Set("SIP/300-00002cdd", "TOUCH_MONITOR=1551964173.16295") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:2] Set("SIP/300-00002cdd", "AMPUSER=300") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:3] GotoIf("SIP/300-00002cdd", "0?report") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:4] ExecIf("SIP/300-00002cdd", "1?Set(REALCALLERIDNUM=300)") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:5] Set("SIP/300-00002cdd", "AMPUSER=300") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:6] GotoIf("SIP/300-00002cdd", "0?limit") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:7] Set("SIP/300-00002cdd", "AMPUSERCIDNAME=LetoCom Office") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:8] ExecIf("SIP/300-00002cdd", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:9] GotoIf("SIP/300-00002cdd", "0?report") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:10] Set("SIP/300-00002cdd", "AMPUSERCID=300") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:11] Set("SIP/300-00002cdd", "__DIAL_OPTIONS=Ttr") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:12] Set("SIP/300-00002cdd", "CALLERID(all)="LetoCom Office" <300>") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:13] GotoIf("SIP/300-00002cdd", "0?limit") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:14] ExecIf("SIP/300-00002cdd", "1?Set(GROUP(concurrency_limit)=300)") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:15] ExecIf("SIP/300-00002cdd", "0?Set(CHANNEL(language)=)") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:16] NoOp("SIP/300-00002cdd", "Macro Depth is 1") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:17] GotoIf("SIP/300-00002cdd", "1?report2:macroerror") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx_builtins.c: Goto (macro-user-callerid,s,18)
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:18] GotoIf("SIP/300-00002cdd", "1?continue") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx_builtins.c: Goto (macro-user-callerid,s,37)
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:37] Set("SIP/300-00002cdd", "CALLERID(number)=300") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:38] Set("SIP/300-00002cdd", "CALLERID(name)=LetoCom Office") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:39] GotoIf("SIP/300-00002cdd", "0?cnum") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]lerid:40] Set("SIP/300-00002cdd", "CDR(cnam)=LetoCom Office") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:41] Set("SIP/300-00002cdd", "CDR(cnum)=300") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:42] Set("SIP/300-00002cdd", "CHANNEL(language)=en") in new stack
[2019-03-07 08:09:33] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:2] Set("SIP/300-00002cdd", "MOHCLASS=default") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:3] Set("SIP/300-00002cdd", "LANGUAGE()=en") in new stack
[2019-03-07 08:09:34] ERROR[4272][C-0000ca6c] pbx_functions.c: Function LANGUAGE not registered
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:4] Set("SIP/300-00002cdd", "_NODEST=") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:5] NoCDR("SIP/300-00002cdd", "") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:6] Macro("SIP/300-00002cdd", "dialout-trunk,1,5183657500,,on") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:1] Set("SIP/300-00002cdd", "DIAL_TRUNK=1") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:2] ExecIf("SIP/300-00002cdd", "0?Set(DIAL_OPTIONS=tr)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:3] GosubIf("SIP/300-00002cdd", "0?sub-pincheck,s,1()") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:4] GotoIf("SIP/300-00002cdd", "0?disabletrunk,1") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:5] Set("SIP/300-00002cdd", "DIAL_NUMBER=5183657500") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:6] Set("SIP/300-00002cdd", "DIAL_TRUNK_OPTIONS=Ttr") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:7] Set("SIP/300-00002cdd", "OUTBOUND_GROUP=OUT_1") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:8] Set("SIP/300-00002cdd", "DIAL_TRUNK_OPTIONS=T") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:9] GotoIf("SIP/300-00002cdd", "0?nomax") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:10] GotoIf("SIP/300-00002cdd", "0?chanfull") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:11] GotoIf("SIP/300-00002cdd", "0?skipoutcid") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:12] Macro("SIP/300-00002cdd", "outbound-callerid,1") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:1] ExecIf("SIP/300-00002cdd", "0?Set(CALLERPRES(name-pres)=)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:2] ExecIf("SIP/300-00002cdd", "0?Set(CALLERPRES(num-pres)=)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:3] ExecIf("SIP/300-00002cdd", "0?Set(REALCALLERIDNUM=300)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:4] ExecIf("SIP/300-00002cdd", "0?Set(AMPUSER=)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:5] GotoIf("SIP/300-00002cdd", "1?normcid") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx_builtins.c: Goto (macro-outbound-callerid,s,9)
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:9] Set("SIP/300-00002cdd", "USEROUTCID=") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:10] Set("SIP/300-00002cdd", "EMERGENCYCID=") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:11] Set("SIP/300-00002cdd", "TRUNKOUTCID=501") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:12] GotoIf("SIP/300-00002cdd", "1?trunkcid") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx_builtins.c: Goto (macro-outbound-callerid,s,17)
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:17] ExecIf("SIP/300-00002cdd", "1?Set(CALLERID(all)=501)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:18] ExecIf("SIP/300-00002cdd", "0?Set(CALLERID(all)=)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:19] ExecIf("SIP/300-00002cdd", "0?Set(CALLERID(all)=)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:20] ExecIf("SIP/300-00002cdd", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:21] ExecIf("SIP/300-00002cdd", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:22] Set("SIP/300-00002cdd", "CDR(outbound_cnum)=501") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:23] Set("SIP/300-00002cdd", "CDR(outbound_cnam)=") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:13] GosubIf("SIP/300-00002cdd", "0?sub-flp-1,s,1()") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:14] Set("SIP/300-00002cdd", "OUTNUM=5183657500") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:15] Set("SIP/300-00002cdd", "custom=SIP/0124487") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:16] ExecIf("SIP/300-00002cdd", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:17] ExecIf("SIP/300-00002cdd", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:18] Macro("SIP/300-00002cdd", "dialout-trunk-predial-hook,") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:1] MacroExit("SIP/300-00002cdd", "") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:19] GotoIf("SIP/300-00002cdd", "0?skipcrm") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:20] Set("SIP/300-00002cdd", "__CRM_DIRECTION=OUTBOUND") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:21] Set("SIP/300-00002cdd", "__CRM_DESTINATION=5183657500") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:22] Set("SIP/300-00002cdd", "__CRM_SOURCE=300") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:23] AGI("SIP/300-00002cdd", "sangomacrm.agi") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] res_agi.c: <SIP/300-00002cdd>AGI Script sangomacrm.agi completed, returning 0
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:24] Set("SIP/300-00002cdd", "CHANNEL(hangup_handler_push)=crm-hangup,s,1") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]cro-dialout-trunk:25] NoOp("SIP/300-00002cdd", "CRM Finished") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:26] GotoIf("SIP/300-00002cdd", "0?bypass,1") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:27] ExecIf("SIP/300-00002cdd", "1?Set(CONNECTEDLINE(num,i)=5183657500)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:28] ExecIf("SIP/300-00002cdd", "1?Set(CONNECTEDLINE(name,i)=CID:501)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:29] ExecIf("SIP/300-00002cdd", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)501)") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:30] GotoIf("SIP/300-00002cdd", "0?customtrunk") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:31] Dial("SIP/300-00002cdd", "SIP/0124487/5183657500,300,T") in new stack
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] netsock2.c: Using SIP RTP TOS bits 184
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] netsock2.c: Using SIP RTP CoS mark 5
[2019-03-07 08:09:34] VERBOSE[4272][C-0000ca6c] app_dial.c: Called SIP/0124487/5183657500
[2019-03-07 08:09:37] VERBOSE[4272][C-0000ca6c] app_dial.c: SIP/0124487-00002cde is ringing
[2019-03-07 08:09:37] VERBOSE[4272][C-0000ca6c] app_dial.c: SIP/0124487-00002cde answered SIP/300-00002cdd
[2019-03-07 08:09:37] VERBOSE[4277][C-0000ca6c] bridge_channel.c: Channel SIP/0124487-00002cde joined 'simple_bridge' basic-bridge <1eb824c5-b8e5-4310-9d18-c90bab61b816>
[2019-03-07 08:09:37] VERBOSE[4272][C-0000ca6c] bridge_channel.c: Channel SIP/300-00002cdd joined 'simple_bridge' basic-bridge <1eb824c5-b8e5-4310-9d18-c90bab61b816>
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] bridge_channel.c: Channel SIP/300-00002cdd left 'simple_bridge' basic-bridge <1eb824c5-b8e5-4310-9d18-c90bab61b816>
[2019-03-07 08:09:42] VERBOSE[4277][C-0000ca6c] bridge_channel.c: Channel SIP/0124487-00002cde left 'simple_bridge' basic-bridge <1eb824c5-b8e5-4310-9d18-c90bab61b816>
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] app_macro.c: Spawn extension (macro-dialout-trunk, s, 31) exited non-zero on 'SIP/300-00002cdd' in macro 'dialout-trunk'
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Spawn extension (from-internal, 5183657500, 6) exited non-zero on 'SIP/300-00002cdd'
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:1] Macro("SIP/300-00002cdd", "hangupcall") in new stack
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:1] GotoIf("SIP/300-00002cdd", "1?theend") in new stack
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:3] ExecIf("SIP/300-00002cdd", "0?Set(CDR(recordingfile)=)") in new stack
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:4] Hangup("SIP/300-00002cdd", "") in new stack
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'SIP/300-00002cdd' in macro 'hangupcall'
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/300-00002cdd'
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] app_stack.c: SIP/300-00002cdd Internal Gosub(crm-hangup,s,1) start
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:1] NoOp("SIP/300-00002cdd", "Sending Hangup to CRM") in new stack
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:2] NoOp("SIP/300-00002cdd", "HANGUP CAUSE: 16") in new stack
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:3] ExecIf("SIP/300-00002cdd", "0?Set(__CRM_VOICEMAIL=)") in new stack
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:4] NoOp("SIP/300-00002cdd", "MASTER CHANNEL: 1551964173.16295 = 1551964173.16295") in new stack
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:5] GotoIf("SIP/300-00002cdd", "0?return") in new stack
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:6] Set("SIP/300-00002cdd", "__CRM_HANGUP=1") in new stack
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:7] AGI("SIP/300-00002cdd", "sangomacrm.agi") in new stack
[2019-03-07 08:09:42] VERBOSE[4272][C-0000ca6c] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
[2019-03-07 08:09:43] VERBOSE[4272][C-0000ca6c] res_agi.c: <SIP/300-00002cdd>AGI Script sangomacrm.agi completed, returning 0
[2019-03-07 08:09:43] VERBOSE[4272][C-0000ca6c] pbx.c: Executing [[email protected]:8] Return("SIP/300-00002cdd", "") in new stack
[2019-03-07 08:09:43] VERBOSE[4272][C-0000ca6c] app_stack.c: Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/300-00002cdd'
[2019-03-07 08:09:43] VERBOSE[4272][C-0000ca6c] app_stack.c: SIP/300-00002cdd Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=