Fresh install PBX14. Trunks and routes setup done, all calls in local and to external phones going good.
But redirect from Trunk number to Misc Destination external phone is didn’t work.This is log. Can u help me with advice?
1111111 - make call from this number
222222 - trunk number
333333 - redirect to this number
[2017-12-31 12:48:58] VERBOSE[2138][C-00000013] netsock2.c: Using SIP RTP TOS bits 184
[2017-12-31 12:48:58] VERBOSE[2138][C-00000013] netsock2.c: Using SIP RTP CoS mark 5
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk-sip-TELPHIN:1] Set(“SIP/inbound_telphin-00000012”, “GROUP()=OUT_1”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk-sip-TELPHIN:2] Goto(“SIP/inbound_telphin-00000012”, “from-trunk,8122222222,1”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx_builtins.c: Goto (from-trunk,8122222222,1)
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:1] Set(“SIP/inbound_telphin-00000012”, “__DIRECTION=INBOUND”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:2] Gosub(“SIP/inbound_telphin-00000012”, “sub-record-check,s,1(in,8122222222,dontcare)”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:1] GotoIf(“SIP/inbound_telphin-00000012”, “0?initialized”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:2] Set(“SIP/inbound_telphin-00000012”, “__REC_STATUS=INITIALIZED”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:3] Set(“SIP/inbound_telphin-00000012”, “NOW=1514724538”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:4] Set(“SIP/inbound_telphin-00000012”, “__DAY=31”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:5] Set(“SIP/inbound_telphin-00000012”, “__MONTH=12”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:6] Set(“SIP/inbound_telphin-00000012”, “__YEAR=2017”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:7] Set(“SIP/inbound_telphin-00000012”, “__TIMESTR=20171231-124858”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:8] Set(“SIP/inbound_telphin-00000012”, “__FROMEXTEN=unknown”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:9] Set(“SIP/inbound_telphin-00000012”, “__MON_FMT=wav”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:10] NoOp(“SIP/inbound_telphin-00000012”, “Recordings initialized”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:11] ExecIf(“SIP/inbound_telphin-00000012”, “0?Set(ARG3=dontcare)”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:12] Set(“SIP/inbound_telphin-00000012”, “REC_POLICY_MODE_SAVE=”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:13] ExecIf(“SIP/inbound_telphin-00000012”, “0?Set(REC_STATUS=NO)”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:14] GotoIf(“SIP/inbound_telphin-00000012”, “2?checkaction”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx_builtins.c: Goto (sub-record-check,s,17)
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@sub-record-check:17] GotoIf(“SIP/inbound_telphin-00000012”, “1?sub-record-check,in,1”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx_builtins.c: Goto (sub-record-check,in,1)
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [in@sub-record-check:1] NoOp(“SIP/inbound_telphin-00000012”, “Inbound Recording Check to 8122222222”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [in@sub-record-check:2] Set(“SIP/inbound_telphin-00000012”, “FROMEXTEN=unknown”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [in@sub-record-check:3] ExecIf(“SIP/inbound_telphin-00000012”, “12?Set(FROMEXTEN=+79531111111)”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [in@sub-record-check:4] Gosub(“SIP/inbound_telphin-00000012”, “recordcheck,1(dontcare,in,8122222222)”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“SIP/inbound_telphin-00000012”, “Starting recording check against dontcare”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“SIP/inbound_telphin-00000012”, “dontcare”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“SIP/inbound_telphin-00000012”, “”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [in@sub-record-check:5] Return(“SIP/inbound_telphin-00000012”, “”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:3] Gosub(“SIP/inbound_telphin-00000012”, “app-blacklist-check,s,1()”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@app-blacklist-check:1] GotoIf(“SIP/inbound_telphin-00000012”, “0?blacklisted”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@app-blacklist-check:2] Set(“SIP/inbound_telphin-00000012”, “CALLED_BLACKLIST=1”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@app-blacklist-check:3] Return(“SIP/inbound_telphin-00000012”, “”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:4] Set(“SIP/inbound_telphin-00000012”, “__FROM_DID=8122222222”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:5] Set(“SIP/inbound_telphin-00000012”, “CDR(did)=8122222222”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:6] ExecIf(“SIP/inbound_telphin-00000012”, “0 ?Set(CALLERID(name)=+79531111111)”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:7] Set(“SIP/inbound_telphin-00000012”, “__MOHCLASS=”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:8] Set(“SIP/inbound_telphin-00000012”, “__REVERSAL_REJECT=FALSE”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:9] GotoIf(“SIP/inbound_telphin-00000012”, “1?post-reverse-charge”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx_builtins.c: Goto (from-trunk,8122222222,11)
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:11] NoOp(“SIP/inbound_telphin-00000012”, “”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:12] Set(“SIP/inbound_telphin-00000012”, “__CALLINGNAMEPRES_SV=allowed_not_screened”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:13] Set(“SIP/inbound_telphin-00000012”, “__CALLINGNUMPRES_SV=allowed_not_screened”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:14] Set(“SIP/inbound_telphin-00000012”, “CALLERID(name-pres)=allowed_not_screened”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:15] Set(“SIP/inbound_telphin-00000012”, “CALLERID(num-pres)=allowed_not_screened”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:16] NoOp(“SIP/inbound_telphin-00000012”, “CallerID Entry Point”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:17] Set(“SIP/inbound_telphin-00000012”, “__CRM_DIRECTION=INBOUND”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:18] Set(“SIP/inbound_telphin-00000012”, “__CRM_SOURCE=+79531111111”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:19] Set(“SIP/inbound_telphin-00000012”, “__CRM_LINKEDID=1514724538.26”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:20] ExecIf(“SIP/inbound_telphin-00000012”, “1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [8122222222@from-trunk:21] Goto(“SIP/inbound_telphin-00000012”, “ext-miscdests,1,1”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx_builtins.c: Goto (ext-miscdests,1,1)
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [1@ext-miscdests:1] NoOp(“SIP/inbound_telphin-00000012”, “MiscDest: Phone”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [1@ext-miscdests:2] Goto(“SIP/inbound_telphin-00000012”, “from-internal,89653333333,1”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx_builtins.c: Goto (from-internal,89653333333,1)
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [89653333333@from-internal:1] Macro(“SIP/inbound_telphin-00000012”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:1] Set(“SIP/inbound_telphin-00000012”, “TOUCH_MONITOR=1514724538.26”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:2] Set(“SIP/inbound_telphin-00000012”, “AMPUSER=+79531111111”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“SIP/inbound_telphin-00000012”, “0?report”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“SIP/inbound_telphin-00000012”, “1?Set(REALCALLERIDNUM=+79531111111)”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:5] Set(“SIP/inbound_telphin-00000012”, “AMPUSER=”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“SIP/inbound_telphin-00000012”, “0?limit”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:7] Set(“SIP/inbound_telphin-00000012”, “AMPUSERCIDNAME=”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:8] ExecIf(“SIP/inbound_telphin-00000012”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:9] GotoIf(“SIP/inbound_telphin-00000012”, “1?report”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx_builtins.c: Goto (macro-user-callerid,s,16)
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:16] NoOp(“SIP/inbound_telphin-00000012”, “Macro Depth is 1”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:17] GotoIf(“SIP/inbound_telphin-00000012”, “1?report2:macroerror”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx_builtins.c: Goto (macro-user-callerid,s,19)
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:19] GotoIf(“SIP/inbound_telphin-00000012”, “1?continue”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx_builtins.c: Goto (macro-user-callerid,s,37)
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:37] Set(“SIP/inbound_telphin-00000012”, “CALLERID(number)=+79531111111”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:38] Set(“SIP/inbound_telphin-00000012”, “CALLERID(name)=+79531111111”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:39] GotoIf(“SIP/inbound_telphin-00000012”, “0?cnum”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:40] Set(“SIP/inbound_telphin-00000012”, “CDR(cnam)=+79531111111”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:41] Set(“SIP/inbound_telphin-00000012”, “CDR(cnum)=+79531111111”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-user-callerid:42] Set(“SIP/inbound_telphin-00000012”, “CHANNEL(language)=ru”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [89653333333@from-internal:2] NoCDR(“SIP/inbound_telphin-00000012”, “”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [89653333333@from-internal:3] Progress(“SIP/inbound_telphin-00000012”, “”) in new stack
[2017-12-31 12:48:58] VERBOSE[56718][C-00000013] pbx.c: Executing [89653333333@from-internal:4] Wait(“SIP/inbound_telphin-00000012”, “1”) in new stack
[2017-12-31 12:48:59] VERBOSE[56718][C-00000013] pbx.c: Executing [89653333333@from-internal:5] Playback(“SIP/inbound_telphin-00000012”, “silence/1&cannot-complete-as-dialed&check-number-dial-again,noanswer”) in new stack
[2017-12-31 12:48:59] VERBOSE[56718][C-00000013] file.c: <SIP/inbound_telphin-00000012> Playing ‘silence/1.ulaw’ (language ‘ru’)
[2017-12-31 12:49:00] VERBOSE[56718][C-00000013] file.c: <SIP/inbound_telphin-00000012> Playing ‘cannot-complete-as-dialed.ulaw’ (language ‘ru’)
[2017-12-31 12:49:02] VERBOSE[56718][C-00000013] file.c: <SIP/inbound_telphin-00000012> Playing ‘check-number-dial-again.ulaw’ (language ‘ru’)
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [h@from-internal:1] Macro(“SIP/inbound_telphin-00000012”, “hangupcall”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-hangupcall:1] GotoIf(“SIP/inbound_telphin-00000012”, “1?theend”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-hangupcall:3] ExecIf(“SIP/inbound_telphin-00000012”, “0?Set(CDR(recordingfile)=)”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-hangupcall:4] NoOp(“SIP/inbound_telphin-00000012”, " monior file= ") in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-hangupcall:5] AGI(“SIP/inbound_telphin-00000012”, “attendedtransfer-rec-restart.php,”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/attendedtransfer-rec-restart.php
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] res_agi.c: <SIP/inbound_telphin-00000012>AGI Script attendedtransfer-rec-restart.php completed, returning 0
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@macro-hangupcall:6] Hangup(“SIP/inbound_telphin-00000012”, “”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] app_macro.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on ‘SIP/inbound_telphin-00000012’ in macro ‘hangupcall’
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/inbound_telphin-00000012’
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] app_stack.c: SIP/inbound_telphin-00000012 Internal Gosub(crm-hangup,s,1) start
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@crm-hangup:1] NoOp(“SIP/inbound_telphin-00000012”, “Sending Hangup to CRM”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@crm-hangup:2] NoOp(“SIP/inbound_telphin-00000012”, “HANGUP CAUSE: 16”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@crm-hangup:3] ExecIf(“SIP/inbound_telphin-00000012”, “0?Set(__CRM_VOICEMAIL=)”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@crm-hangup:4] NoOp(“SIP/inbound_telphin-00000012”, “MASTER CHANNEL: 1514724538.26 = 1514724538.26”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@crm-hangup:5] GotoIf(“SIP/inbound_telphin-00000012”, “0?return”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@crm-hangup:6] Set(“SIP/inbound_telphin-00000012”, “__CRM_HANGUP=1”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@crm-hangup:7] AGI(“SIP/inbound_telphin-00000012”, “sangomacrm.agi”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] res_agi.c: <SIP/inbound_telphin-00000012>AGI Script sangomacrm.agi completed, returning 0
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] pbx.c: Executing [s@crm-hangup:8] Return(“SIP/inbound_telphin-00000012”, “”) in new stack
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] app_stack.c: Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/inbound_telphin-00000012’
[2017-12-31 12:49:05] VERBOSE[56718][C-00000013] app_stack.c: SIP/inbound_telphin-00000012 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=