Extension busy/unavailable bulk import

chaptech · August 14, 2019, 6:40am

Howdy all.

I have a new build latest stable freepbx. I used the bulk import to export out a single extension then used that template to bulk import around 60 extensions, everything worked fine, Yealink T46S phone registers ok but i get when i call in i get user busy ( paste below ) when voicemail is disabled or extension unavailable voicemail when voicemail on.

if i delete and recreate the extension works fine, so its something in the imported ones thats not right. i looked all through the extension config and the only thing i could see different in advanced was the aggregate mwi setting but changing that did not resolve the problem.

Can anyone see below what the issue is? I really don’t want to have to recreate all the extensions by hand manually

thanks in advance

  == Using SIP RTP TOS bits 184
  == Using SIP RTP CoS mark 5
       > 0x7f56c8057ca0 -- Strict RTP learning after remote address set to: 103.60.23.7:10854
    -- Executing [0748648034@from-trunk-sip-0003*026:1] Set("SIP/0003*026-00000026", "GROUP()=OUT_1") in new stack
    -- Executing [0748648034@from-trunk-sip-0003*026:2] Goto("SIP/0003*026-00000026", "from-trunk,0748648034,1") in new stack
    -- Goto (from-trunk,0748648034,1)
    -- Executing [0748648034@from-trunk:1] Set("SIP/0003*026-00000026", "__DIRECTION=INBOUND") in new stack
    -- Executing [0748648034@from-trunk:2] Gosub("SIP/0003*026-00000026", "sub-record-check,s,1(in,0748648034,dontcare)") in new stack
    -- Executing [s@sub-record-check:1] GotoIf("SIP/0003*026-00000026", "0?initialized") in new stack
    -- Executing [s@sub-record-check:2] Set("SIP/0003*026-00000026", "__REC_STATUS=INITIALIZED") in new stack
    -- Executing [s@sub-record-check:3] Set("SIP/0003*026-00000026", "NOW=1565764585") in new stack
    -- Executing [s@sub-record-check:4] Set("SIP/0003*026-00000026", "__DAY=14") in new stack
    -- Executing [s@sub-record-check:5] Set("SIP/0003*026-00000026", "__MONTH=08") in new stack
    -- Executing [s@sub-record-check:6] Set("SIP/0003*026-00000026", "__YEAR=2019") in new stack
    -- Executing [s@sub-record-check:7] Set("SIP/0003*026-00000026", "__TIMESTR=20190814-063625") in new stack
    -- Executing [s@sub-record-check:8] Set("SIP/0003*026-00000026", "__FROMEXTEN=unknown") in new stack
    -- Executing [s@sub-record-check:9] Set("SIP/0003*026-00000026", "__MON_FMT=wav") in new stack
    -- Executing [s@sub-record-check:10] NoOp("SIP/0003*026-00000026", "Recordings initialized") in new stack
    -- Executing [s@sub-record-check:11] ExecIf("SIP/0003*026-00000026", "0?Set(ARG3=dontcare)") in new stack
    -- Executing [s@sub-record-check:12] Set("SIP/0003*026-00000026", "REC_POLICY_MODE_SAVE=") in new stack
    -- Executing [s@sub-record-check:13] ExecIf("SIP/0003*026-00000026", "0?Set(REC_STATUS=NO)") in new stack
    -- Executing [s@sub-record-check:14] GotoIf("SIP/0003*026-00000026", "2?checkaction") in new stack
    -- Goto (sub-record-check,s,17)
    -- Executing [s@sub-record-check:17] GotoIf("SIP/0003*026-00000026", "1?sub-record-check,in,1") in new stack
    -- Goto (sub-record-check,in,1)
    -- Executing [in@sub-record-check:1] NoOp("SIP/0003*026-00000026", "Inbound Recording Check to 0748648034") in new stack
    -- Executing [in@sub-record-check:2] Set("SIP/0003*026-00000026", "FROMEXTEN=unknown") in new stack
    -- Executing [in@sub-record-check:3] ExecIf("SIP/0003*026-00000026", "10?Set(FROMEXTEN=0409763293)") in new stack
    -- Executing [in@sub-record-check:4] Gosub("SIP/0003*026-00000026", "recordcheck,1(dontcare,in,0748648034)") in new stack
    -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/0003*026-00000026", "Starting recording check against dontcare") in new stack
    -- Executing [recordcheck@sub-record-check:2] Goto("SIP/0003*026-00000026", "dontcare") in new stack
    -- Goto (sub-record-check,recordcheck,3)
    -- Executing [recordcheck@sub-record-check:3] Return("SIP/0003*026-00000026", "") in new stack
    -- Executing [in@sub-record-check:5] Return("SIP/0003*026-00000026", "") in new stack
    -- Executing [0748648034@from-trunk:3] Set("SIP/0003*026-00000026", "CHANNEL(tonezone)=us") in new stack
    -- Executing [0748648034@from-trunk:4] Set("SIP/0003*026-00000026", "__FROM_DID=0748648034") in new stack
    -- Executing [0748648034@from-trunk:5] Set("SIP/0003*026-00000026", "returnhere=1") in new stack
    -- Executing [0748648034@from-trunk:6] Gosub("SIP/0003*026-00000026", "app-blacklist-check,s,1()") in new stack
    -- Executing [s@app-blacklist-check:1] GotoIf("SIP/0003*026-00000026", "0?blacklisted") in new stack
    -- Executing [s@app-blacklist-check:2] Set("SIP/0003*026-00000026", "CALLED_BLACKLIST=1") in new stack
    -- Executing [s@app-blacklist-check:3] Return("SIP/0003*026-00000026", "") in new stack
    -- Executing [0748648034@from-trunk:7] Set("SIP/0003*026-00000026", "CDR(did)=0748648034") in new stack
    -- Executing [0748648034@from-trunk:8] GotoIf("SIP/0003*026-00000026", "0?") in new stack
    -- Executing [0748648034@from-trunk:9] ExecIf("SIP/0003*026-00000026", "0 ?Set(CALLERID(name)=0409763293)") in new stack
    -- Executing [0748648034@from-trunk:10] Set("SIP/0003*026-00000026", "__MOHCLASS=") in new stack
    -- Executing [0748648034@from-trunk:11] Set("SIP/0003*026-00000026", "__REVERSAL_REJECT=FALSE") in new stack
    -- Executing [0748648034@from-trunk:12] GotoIf("SIP/0003*026-00000026", "1?post-reverse-charge") in new stack
    -- Goto (from-trunk,0748648034,14)
    -- Executing [0748648034@from-trunk:14] NoOp("SIP/0003*026-00000026", "") in new stack
    -- Executing [0748648034@from-trunk:15] Set("SIP/0003*026-00000026", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
    -- Executing [0748648034@from-trunk:16] Set("SIP/0003*026-00000026", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
    -- Executing [0748648034@from-trunk:17] Set("SIP/0003*026-00000026", "CALLERID(name-pres)=allowed_not_screened") in new stack
    -- Executing [0748648034@from-trunk:18] Set("SIP/0003*026-00000026", "CALLERID(num-pres)=allowed_not_screened") in new stack
    -- Executing [0748648034@from-trunk:19] NoOp("SIP/0003*026-00000026", "CallerID Entry Point") in new stack
    -- Executing [0748648034@from-trunk:20] Set("SIP/0003*026-00000026", "__CRM_DIRECTION=INBOUND") in new stack
    -- Executing [0748648034@from-trunk:21] Set("SIP/0003*026-00000026", "__CRM_SOURCE=0409763293") in new stack
    -- Executing [0748648034@from-trunk:22] Set("SIP/0003*026-00000026", "__CRM_LINKEDID=1565764585.39") in new stack
    -- Executing [0748648034@from-trunk:23] ExecIf("SIP/0003*026-00000026", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
    -- Executing [0748648034@from-trunk:24] Goto("SIP/0003*026-00000026", "from-did-direct,0748648034,1") in new stack
    -- Goto (from-did-direct,0748648034,1)
    -- Executing [0748648034@from-did-direct:1] GotoIf("SIP/0003*026-00000026", "1?ext-local,0748648034,1:followme-check,0748648034,1") in new stack
    -- Goto (ext-local,0748648034,1)
    -- Executing [0748648034@ext-local:1] Set("SIP/0003*026-00000026", "__RINGTIMER=15") in new stack
    -- Executing [0748648034@ext-local:2] Macro("SIP/0003*026-00000026", "exten-vm,novm,0748648034,0,0,0") in new stack
    -- Executing [s@macro-exten-vm:1] Macro("SIP/0003*026-00000026", "user-callerid,") in new stack
    -- Executing [s@macro-user-callerid:1] Set("SIP/0003*026-00000026", "TOUCH_MONITOR=1565764585.39") in new stack
    -- Executing [s@macro-user-callerid:2] Set("SIP/0003*026-00000026", "AMPUSER=0409763293") in new stack
    -- Executing [s@macro-user-callerid:3] GotoIf("SIP/0003*026-00000026", "0?report") in new stack
    -- Executing [s@macro-user-callerid:4] ExecIf("SIP/0003*026-00000026", "1?Set(REALCALLERIDNUM=0409763293)") in new stack
    -- Executing [s@macro-user-callerid:5] Set("SIP/0003*026-00000026", "AMPUSER=") in new stack
    -- Executing [s@macro-user-callerid:6] GotoIf("SIP/0003*026-00000026", "0?limit") in new stack
    -- Executing [s@macro-user-callerid:7] Set("SIP/0003*026-00000026", "AMPUSERCIDNAME=") in new stack
    -- Executing [s@macro-user-callerid:8] ExecIf("SIP/0003*026-00000026", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
    -- Executing [s@macro-user-callerid:9] GotoIf("SIP/0003*026-00000026", "1?report") in new stack
    -- Goto (macro-user-callerid,s,17)
    -- Executing [s@macro-user-callerid:17] NoOp("SIP/0003*026-00000026", "Macro Depth is 2") in new stack
    -- Executing [s@macro-user-callerid:18] GotoIf("SIP/0003*026-00000026", "1?report2:macroerror") in new stack
    -- Goto (macro-user-callerid,s,19)
    -- Executing [s@macro-user-callerid:19] GotoIf("SIP/0003*026-00000026", "0?continue") in new stack
    -- Executing [s@macro-user-callerid:20] ExecIf("SIP/0003*026-00000026", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
    -- Executing [s@macro-user-callerid:21] Set("SIP/0003*026-00000026", "__TTL=64") in new stack
    -- Executing [s@macro-user-callerid:22] GotoIf("SIP/0003*026-00000026", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,38)
    -- Executing [s@macro-user-callerid:38] Set("SIP/0003*026-00000026", "CALLERID(number)=0409763293") in new stack
    -- Executing [s@macro-user-callerid:39] Set("SIP/0003*026-00000026", "CALLERID(name)=0409763293") in new stack
    -- Executing [s@macro-user-callerid:40] GotoIf("SIP/0003*026-00000026", "0?cnum") in new stack
    -- Executing [s@macro-user-callerid:41] Set("SIP/0003*026-00000026", "CDR(cnam)=0409763293") in new stack
    -- Executing [s@macro-user-callerid:42] Set("SIP/0003*026-00000026", "CDR(cnum)=0409763293") in new stack
    -- Executing [s@macro-user-callerid:43] Set("SIP/0003*026-00000026", "CHANNEL(language)=en") in new stack
    -- Executing [s@macro-exten-vm:2] Set("SIP/0003*026-00000026", "RingGroupMethod=none") in new stack
    -- Executing [s@macro-exten-vm:3] Set("SIP/0003*026-00000026", "__EXTTOCALL=0748648034") in new stack
    -- Executing [s@macro-exten-vm:4] Set("SIP/0003*026-00000026", "__PICKUPMARK=0748648034") in new stack
    -- Executing [s@macro-exten-vm:5] Set("SIP/0003*026-00000026", "RT=") in new stack
    -- Executing [s@macro-exten-vm:6] ExecIf("SIP/0003*026-00000026", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
    -- Executing [s@macro-exten-vm:7] ExecIf("SIP/0003*026-00000026", "0?MacroExit()") in new stack
    -- Executing [s@macro-exten-vm:8] ExecIf("SIP/0003*026-00000026", "0?Gosub(ext-intercom,*800748648034,1())") in new stack
    -- Executing [s@macro-exten-vm:9] ExecIf("SIP/0003*026-00000026", "0?MacroExit()") in new stack
    -- Executing [s@macro-exten-vm:10] ExecIf("SIP/0003*026-00000026", "0?ChanSpy(PJSIP/0748648033,q)") in new stack
    -- Executing [s@macro-exten-vm:11] ExecIf("SIP/0003*026-00000026", "0?MacroExit()") in new stack
[2019-08-14 06:36:25] ERROR[30401][C-00000027]: res_pjsip_header_funcs.c:454 func_read_header: This function requires a PJSIP channel.
    -- Executing [s@macro-exten-vm:12] ExecIf("SIP/0003*026-00000026", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
[2019-08-14 06:36:25] ERROR[30401][C-00000027]: res_pjsip_header_funcs.c:454 func_read_header: This function requires a PJSIP channel.
[2019-08-14 06:36:25] ERROR[30401][C-00000027]: res_pjsip_header_funcs.c:454 func_read_header: This function requires a PJSIP channel.
    -- Executing [s@macro-exten-vm:13] ExecIf("SIP/0003*026-00000026", "0?MacroExit()") in new stack
[2019-08-14 06:36:25] ERROR[30401][C-00000027]: res_pjsip_header_funcs.c:454 func_read_header: This function requires a PJSIP channel.
[2019-08-14 06:36:25] ERROR[30401][C-00000027]: res_pjsip_header_funcs.c:454 func_read_header: This function requires a PJSIP channel.
    -- Executing [s@macro-exten-vm:14] ExecIf("SIP/0003*026-00000026", "0?Gosub(ext-intercom,*800748648034,1())") in new stack
[2019-08-14 06:36:25] ERROR[30401][C-00000027]: res_pjsip_header_funcs.c:454 func_read_header: This function requires a PJSIP channel.
[2019-08-14 06:36:25] ERROR[30401][C-00000027]: res_pjsip_header_funcs.c:454 func_read_header: This function requires a PJSIP channel.
    -- Executing [s@macro-exten-vm:15] ExecIf("SIP/0003*026-00000026", "0?MacroExit()") in new stack
[2019-08-14 06:36:25] ERROR[30401][C-00000027]: res_pjsip_header_funcs.c:454 func_read_header: This function requires a PJSIP channel.
[2019-08-14 06:36:25] ERROR[30401][C-00000027]: res_pjsip_header_funcs.c:454 func_read_header: This function requires a PJSIP channel.
    -- Executing [s@macro-exten-vm:16] ExecIf("SIP/0003*026-00000026", "0?ChanSpy(PJSIP/0748648033,q)") in new stack
[2019-08-14 06:36:25] ERROR[30401][C-00000027]: res_pjsip_header_funcs.c:454 func_read_header: This function requires a PJSIP channel.
[2019-08-14 06:36:25] ERROR[30401][C-00000027]: res_pjsip_header_funcs.c:454 func_read_header: This function requires a PJSIP channel.
    -- Executing [s@macro-exten-vm:17] ExecIf("SIP/0003*026-00000026", "0?MacroExit()") in new stack
[2019-08-14 06:36:25] ERROR[30401][C-00000027]: res_pjsip_header_funcs.c:454 func_read_header: This function requires a PJSIP channel.
    -- Executing [s@macro-exten-vm:18] Gosub("SIP/0003*026-00000026", "sub-record-check,s,1(exten,0748648034,dontcare)") in new stack
    -- Executing [s@sub-record-check:1] GotoIf("SIP/0003*026-00000026", "10?initialized") in new stack
    -- Goto (sub-record-check,s,10)
    -- Executing [s@sub-record-check:10] NoOp("SIP/0003*026-00000026", "Recordings initialized") in new stack
    -- Executing [s@sub-record-check:11] ExecIf("SIP/0003*026-00000026", "0?Set(ARG3=dontcare)") in new stack
    -- Executing [s@sub-record-check:12] Set("SIP/0003*026-00000026", "REC_POLICY_MODE_SAVE=") in new stack
    -- Executing [s@sub-record-check:13] ExecIf("SIP/0003*026-00000026", "0?Set(REC_STATUS=NO)") in new stack
    -- Executing [s@sub-record-check:14] GotoIf("SIP/0003*026-00000026", "5?checkaction") in new stack
    -- Goto (sub-record-check,s,17)
    -- Executing [s@sub-record-check:17] GotoIf("SIP/0003*026-00000026", "1?sub-record-check,exten,1") in new stack
    -- Goto (sub-record-check,exten,1)
    -- Executing [exten@sub-record-check:1] NoOp("SIP/0003*026-00000026", "Exten Recording Check between 0409763293 and 0748648034") in new stack
    -- Executing [exten@sub-record-check:2] Set("SIP/0003*026-00000026", "CALLTYPE=external") in new stack
    -- Executing [exten@sub-record-check:3] ExecIf("SIP/0003*026-00000026", "0?Set(CALLTYPE=)") in new stack
    -- Executing [exten@sub-record-check:4] Set("SIP/0003*026-00000026", "CALLEE=dontcare") in new stack
    -- Executing [exten@sub-record-check:5] ExecIf("SIP/0003*026-00000026", "0?Set(CALLEE=dontcare)") in new stack
    -- Executing [exten@sub-record-check:6] GotoIf("SIP/0003*026-00000026", "1?callee") in new stack
    -- Goto (sub-record-check,exten,11)
    -- Executing [exten@sub-record-check:11] Gosub("SIP/0003*026-00000026", "recordcheck,1(dontcare,external,0748648034)") in new stack
    -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/0003*026-00000026", "Starting recording check against dontcare") in new stack
    -- Executing [recordcheck@sub-record-check:2] Goto("SIP/0003*026-00000026", "dontcare") in new stack
    -- Goto (sub-record-check,recordcheck,3)
    -- Executing [recordcheck@sub-record-check:3] Return("SIP/0003*026-00000026", "") in new stack
    -- Executing [exten@sub-record-check:12] Return("SIP/0003*026-00000026", "") in new stack
    -- Executing [s@macro-exten-vm:19] GotoIf("SIP/0003*026-00000026", "1?macrodial") in new stack
    -- Goto (macro-exten-vm,s,25)
    -- Executing [s@macro-exten-vm:25] GosubIf("SIP/0003*026-00000026", "0?clrheader,1()") in new stack
    -- Executing [s@macro-exten-vm:26] Macro("SIP/0003*026-00000026", "dial-one,,HhTtr,0748648034") in new stack
    -- Executing [s@macro-dial-one:1] Set("SIP/0003*026-00000026", "DEXTEN=0748648034") in new stack
    -- Executing [s@macro-dial-one:2] Set("SIP/0003*026-00000026", "__CRM_SOURCE=0409763293") in new stack
    -- Executing [s@macro-dial-one:3] ExecIf("SIP/0003*026-00000026", "0?Set(__EXTTOCALL=0748648034)") in new stack
    -- Executing [s@macro-dial-one:4] Set("SIP/0003*026-00000026", "DIALSTATUS_CW=") in new stack
    -- Executing [s@macro-dial-one:5] GosubIf("SIP/0003*026-00000026", "0?screen,1()") in new stack
    -- Executing [s@macro-dial-one:6] GosubIf("SIP/0003*026-00000026", "0?cf,1()") in new stack
    -- Executing [s@macro-dial-one:7] GotoIf("SIP/0003*026-00000026", "1?skip1") in new stack
    -- Goto (macro-dial-one,s,10)
    -- Executing [s@macro-dial-one:10] GotoIf("SIP/0003*026-00000026", "0?nodial") in new stack
    -- Executing [s@macro-dial-one:11] GotoIf("SIP/0003*026-00000026", "0?continue") in new stack
    -- Executing [s@macro-dial-one:12] Set("SIP/0003*026-00000026", "EXTHASCW=ENABLED") in new stack
    -- Executing [s@macro-dial-one:13] GotoIf("SIP/0003*026-00000026", "0?next1:cwinusebusy") in new stack
    -- Goto (macro-dial-one,s,25)
    -- Executing [s@macro-dial-one:25] GotoIf("SIP/0003*026-00000026", "0?next3:continue") in new stack
    -- Goto (macro-dial-one,s,27)
    -- Executing [s@macro-dial-one:27] GotoIf("SIP/0003*026-00000026", "0?nodial") in new stack
    -- Executing [s@macro-dial-one:28] GosubIf("SIP/0003*026-00000026", "1?dstring,1():dlocal,1()") in new stack
    -- Executing [dstring@macro-dial-one:1] Set("SIP/0003*026-00000026", "DSTRING=") in new stack
    -- Executing [dstring@macro-dial-one:2] Set("SIP/0003*026-00000026", "DEVICES=0748648034") in new stack
    -- Executing [dstring@macro-dial-one:3] ExecIf("SIP/0003*026-00000026", "0?Return()") in new stack
    -- Executing [dstring@macro-dial-one:4] ExecIf("SIP/0003*026-00000026", "0?Set(DEVICES=748648034)") in new stack
    -- Executing [dstring@macro-dial-one:5] Set("SIP/0003*026-00000026", "LOOPCNT=1") in new stack
    -- Executing [dstring@macro-dial-one:6] Set("SIP/0003*026-00000026", "ITER=1") in new stack
    -- Executing [dstring@macro-dial-one:7] Set("SIP/0003*026-00000026", "THISDIAL=PJSIP/0748648033") in new stack
    -- Executing [dstring@macro-dial-one:8] GosubIf("SIP/0003*026-00000026", "1?zap2dahdi,1()") in new stack
    -- Executing [zap2dahdi@macro-dial-one:1] ExecIf("SIP/0003*026-00000026", "0?Return()") in new stack
    -- Executing [zap2dahdi@macro-dial-one:2] Set("SIP/0003*026-00000026", "NEWDIAL=") in new stack
    -- Executing [zap2dahdi@macro-dial-one:3] Set("SIP/0003*026-00000026", "LOOPCNT2=1") in new stack
    -- Executing [zap2dahdi@macro-dial-one:4] Set("SIP/0003*026-00000026", "ITER2=1") in new stack
    -- Executing [zap2dahdi@macro-dial-one:5] Set("SIP/0003*026-00000026", "THISPART2=PJSIP/0748648033") in new stack
    -- Executing [zap2dahdi@macro-dial-one:6] ExecIf("SIP/0003*026-00000026", "0?Set(THISPART2=DAHDIIP/0748648033)") in new stack
    -- Executing [zap2dahdi@macro-dial-one:7] Set("SIP/0003*026-00000026", "NEWDIAL=PJSIP/0748648033&") in new stack
    -- Executing [zap2dahdi@macro-dial-one:8] Set("SIP/0003*026-00000026", "ITER2=2") in new stack
    -- Executing [zap2dahdi@macro-dial-one:9] GotoIf("SIP/0003*026-00000026", "0?begin2") in new stack
    -- Executing [zap2dahdi@macro-dial-one:10] Set("SIP/0003*026-00000026", "THISDIAL=PJSIP/0748648033") in new stack
    -- Executing [zap2dahdi@macro-dial-one:11] Return("SIP/0003*026-00000026", "") in new stack
    -- Executing [dstring@macro-dial-one:9] GotoIf("SIP/0003*026-00000026", "0?docheck") in new stack
    -- Executing [dstring@macro-dial-one:10] NoOp("SIP/0003*026-00000026", "Debug: Found PJSIP Destination PJSIP/0748648033") in new stack
    -- Executing [dstring@macro-dial-one:11] GotoIf("SIP/0003*026-00000026", "0?doset") in new stack
    -- Executing [dstring@macro-dial-one:12] NoOp("SIP/0003*026-00000026", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack
    -- Executing [dstring@macro-dial-one:13] Set("SIP/0003*026-00000026", "THISDIAL=") in new stack
    -- Executing [dstring@macro-dial-one:14] ExecIf("SIP/0003*026-00000026", "1?Set(DIALSTATUS=CHANUNAVAIL)") in new stack
    -- Executing [dstring@macro-dial-one:15] GotoIf("SIP/0003*026-00000026", "1?skipset") in new stack
    -- Goto (macro-dial-one,dstring,17)
    -- Executing [dstring@macro-dial-one:17] Set("SIP/0003*026-00000026", "ITER=2") in new stack
    -- Executing [dstring@macro-dial-one:18] GotoIf("SIP/0003*026-00000026", "0?begin") in new stack
    -- Executing [dstring@macro-dial-one:19] ExecIf("SIP/0003*026-00000026", "1?Return()") in new stack
    -- Executing [s@macro-dial-one:29] GotoIf("SIP/0003*026-00000026", "1?nodial") in new stack
    -- Goto (macro-dial-one,s,60)
    -- Executing [s@macro-dial-one:60] NoOp("SIP/0003*026-00000026", "") in new stack
    -- Executing [s@macro-dial-one:61] ExecIf("SIP/0003*026-00000026", "0?Set(DIALSTATUS=NOANSWER)") in new stack
    -- Executing [s@macro-dial-one:62] NoOp("SIP/0003*026-00000026", "Returned from dial-one with nothing to call and DIALSTATUS: CHANUNAVAIL") in new stack
    -- Executing [s@macro-dial-one:63] MacroExit("SIP/0003*026-00000026", "") in new stack
    -- Executing [s@macro-exten-vm:27] Set("SIP/0003*026-00000026", "SV_DIALSTATUS=CHANUNAVAIL") in new stack
    -- Executing [s@macro-exten-vm:28] GosubIf("SIP/0003*026-00000026", "0?docfu,1()") in new stack
    -- Executing [s@macro-exten-vm:29] GosubIf("SIP/0003*026-00000026", "0?docfb,1()") in new stack
    -- Executing [s@macro-exten-vm:30] Set("SIP/0003*026-00000026", "DIALSTATUS=CHANUNAVAIL") in new stack
    -- Executing [s@macro-exten-vm:31] ExecIf("SIP/0003*026-00000026", "0?MacroExit()") in new stack
    -- Executing [s@macro-exten-vm:32] GotoIf("SIP/0003*026-00000026", "1?s-CHANUNAVAIL,1") in new stack
    -- Goto (macro-exten-vm,s-CHANUNAVAIL,1)
    -- Executing [s-CHANUNAVAIL@macro-exten-vm:1] GotoIf("SIP/0003*026-00000026", "0?exit,1") in new stack
    -- Executing [s-CHANUNAVAIL@macro-exten-vm:2] PlayTones("SIP/0003*026-00000026", "congestion") in new stack
    -- Executing [s-CHANUNAVAIL@macro-exten-vm:3] Congestion("SIP/0003*026-00000026", "10") in new stack
  == Spawn extension (macro-exten-vm, s-CHANUNAVAIL, 3) exited non-zero on 'SIP/0003*026-00000026' in macro 'exten-vm'
  == Spawn extension (ext-local, 0748648034, 2) exited non-zero on 'SIP/0003*026-00000026'
    -- Executing [h@ext-local:1] Macro("SIP/0003*026-00000026", "hangupcall,") in new stack
    -- Executing [s@macro-hangupcall:1] GotoIf("SIP/0003*026-00000026", "1?theend") in new stack
    -- Goto (macro-hangupcall,s,3)
    -- Executing [s@macro-hangupcall:3] ExecIf("SIP/0003*026-00000026", "0?Set(CDR(recordingfile)=)") in new stack
    -- Executing [s@macro-hangupcall:4] NoOp("SIP/0003*026-00000026", " montior file= ") in new stack
    -- Executing [s@macro-hangupcall:5] GotoIf("SIP/0003*026-00000026", "1?skipagi") in new stack
    -- Goto (macro-hangupcall,s,7)
    -- Executing [s@macro-hangupcall:7] Hangup("SIP/0003*026-00000026", "") in new stack
  == Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'SIP/0003*026-00000026' in macro 'hangupcall'
  == Spawn extension (ext-local, h, 1) exited non-zero on 'SIP/0003*026-00000026'
    -- SIP/0003*026-00000026 Internal Gosub(crm-hangup,s,1) start
    -- Executing [s@crm-hangup:1] NoOp("SIP/0003*026-00000026", "Sending Hangup to CRM") in new stack
    -- Executing [s@crm-hangup:2] NoOp("SIP/0003*026-00000026", "HANGUP CAUSE: 34") in new stack
    -- Executing [s@crm-hangup:3] ExecIf("SIP/0003*026-00000026", "0?Set(__CRM_VOICEMAIL=)") in new stack
    -- Executing [s@crm-hangup:4] NoOp("SIP/0003*026-00000026", "MASTER CHANNEL: 1565764585.39 = 1565764585.39") in new stack
    -- Executing [s@crm-hangup:5] GotoIf("SIP/0003*026-00000026", "0?return") in new stack
    -- Executing [s@crm-hangup:6] Set("SIP/0003*026-00000026", "__CRM_HANGUP=1") in new stack
    -- Executing [s@crm-hangup:7] AGI("SIP/0003*026-00000026", "sangomacrm.agi") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
    -- <SIP/0003*026-00000026>AGI Script sangomacrm.agi completed, returning 0
    -- Executing [s@crm-hangup:8] Return("SIP/0003*026-00000026", "") in new stack
  == Spawn extension (ext-local, h, 1) exited non-zero on 'SIP/0003*026-00000026'
    -- SIP/0003*026-00000026 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=

cynjut · August 14, 2019, 1:03pm

First, make sure you are on the latest version of the Bulk Handler. If you are, look through the ticket database and see if this hasn’t been reported already (it sounds kind-of familiar). If not, put in a ticket to get it looked at.

Finistrom isn’t here any more and he worked on the importer, so it must be his fault.

lgaetz · August 14, 2019, 1:13pm

If you edit a non-working extension and submit without any changes, does that also fix? If so, you are missing critical ASTDB values indicating a problem with the bulk import.

chaptech · August 14, 2019, 10:37pm

no i have edited and submitted the config many times with no improvement, i have only checked the gui not any conf files yet i might do a find in the /etc dir for a couple extensions and see if any obvious difference

chaptech · August 14, 2019, 11:50pm

here is an extension created in the gui that works fine

extensions_additional.conf

exten => _*96111444.,1,Set(toext=${EXTEN:9})
exten => _*96111444.,n,Goto(app-cf-toggle,*96,setdirect)
exten => 111444,1,Set(__RINGTIMER=${IF($["${DB(AMPUSER/111444/ringtimer)}" > “0”]?${DB(AMPUSER/111444/ringtimer)}:${RINGTIMER_DEFAULT})})
exten => 111444,n,Macro(exten-vm,novm,111444,0,0,0)
exten => 111444,n(dest),Set(__PICKUPMARK=)
exten => 111444,n,GotoIf($["${IVR_CONTEXT}" != “”]?${IVR_CONTEXT},return,1)
exten => 111444,hint,PJSIP/111444&Custom:DND111444,CustomPresence:111444

pjsip.aor.conf

[111444]
type=aor
mailboxes=111444@device

max_contacts=1
remove_existing=yes
maximum_expiration=7200
qualify_frequency=60

pjsip.auth.conf

[111444-auth]
type=auth
auth_type=userpass
password=0b1cc8534b689ee31192a84bbd0e6a22
username=111444

pjsip.endpoint.conf

[111444]
type=endpoint
aors=111444
auth=111444-auth
tos_audio=ef
tos_video=af41
cos_audio=5
cos_video=4
allow=ulaw,alaw,h264,mpeg4
context=from-internal
callerid=testing <111444>

chaptech · August 15, 2019, 12:03am

in additional.conf for the imported ones there is a tonne more stuff

extensions_additional.conf

exten => 0748648034,1,Set(__DIRECTION=INBOUND)
exten => 0748648034,n,Gosub(sub-record-check,s,1(in,${EXTEN},dontcare))
exten => 0748648034,n,Set(CHANNEL(tonezone)=us)
exten => 0748648034,n,Set(__FROM_DID=${EXTEN})
exten => 0748648034,n,Set(returnhere=1)
exten => 0748648034,n,Gosub(app-blacklist-check,s,1())
exten => 0748648034,n(did),Set(CDR(did)=${FROM_DID})
exten => 0748648034,n,GotoIf(${LEN(${BLDEST})}?${BLDEST})
exten => 0748648034,n(callerid),ExecIf($[ “${CALLERID(name)}” = “” ] ?Set(CALLERID(name)=${CALLERID(num)}))
exten => 0748648034,n,Set(__MOHCLASS=)
exten => 0748648034,n,Set(__REVERSAL_REJECT=FALSE)
exten => 0748648034,n,GotoIf($["${REVERSAL_REJECT}"!=“TRUE”]?post-reverse-charge)
exten => 0748648034,n,GotoIf($["${CHANNEL(reversecharge)}"=“1”]?macro-hangupcall)
exten => 0748648034,n(post-reverse-charge),Noop()
exten => 0748648034,n,Set(__CALLINGNAMEPRES_SV=${CALLERID(name-pres)})
exten => 0748648034,n,Set(__CALLINGNUMPRES_SV=${CALLERID(num-pres)})
exten => 0748648034,n,Set(CALLERID(name-pres)=allowed_not_screened)
exten => 0748648034,n,Set(CALLERID(num-pres)=allowed_not_screened)
exten => 0748648034,n(did-cid-hook),Noop(CallerID Entry Point)
exten => 0748648034,n,Set(__CRM_DIRECTION=INBOUND)
exten => 0748648034,n,Set(__CRM_SOURCE=${CALLERID(num)})
exten => 0748648034,n,Set(__CRM_LINKEDID=${CHANNEL(LINKEDID)})
exten => 0748648034,n,ExecIf($["${CRM_DIRECTION}"=“INBOUND”]?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1))
exten => 0748648034,n(dest-ext),Goto(from-did-direct,0748648034,1)
exten => 0748648034,1,GotoIf($[${DB_EXISTS(AMPUSER/${EXTEN}/followme/ddial)} != 1 | “${DB(AMPUSER/${EXTEN}/followme/ddial)}” = “EXTENSION”]?ext-local,${EXTEN},1:followme-check,${EXTEN},1)
exten => _RG-0748648034*.,1+1,Macro(dial,${DB(AMPUSER/0748648034/followme/grptime)},${DIAL_OPTIONS}M(confirm^^^0748648034),${EXTEN:15})
exten => 0748648034,1,Set(__RINGTIMER=${IF($["${DB(AMPUSER/0748648034/ringtimer)}" > “0”]?${DB(AMPUSER/0748648034/ringtimer)}:${RINGTIMER_DEFAULT})})
exten => 0748648034,n,Macro(exten-vm,novm,0748648034,0,0,0)
exten => 0748648034,n(dest),Set(__PICKUPMARK=)
exten => 0748648034,n,GotoIf($["${IVR_CONTEXT}" != “”]?${IVR_CONTEXT},return,1)
exten => 0748648034,hint,PJSIP/0748648033&Custom:DND0748648034,CustomPresence:0748648034

system · August 22, 2019, 12:11am

This topic was automatically closed 7 days after the last reply. New replies are no longer allowed.