FreePBX call not routing



  • I have a skyetel trunk delivering several DIDs to my FreePBX 15 (asterisk 16) system.

    I added a new DID to Skyetel yesterday and also to my FreePBX and setup a destination - I'm getting "the-number-you-have-dialed-is-not-in-service" message from FreePBX.

    Quick googling has lead me to an IP missmatch on the Skyetel trunk, so the system is rejecting the call basically.

    Here is a log for the failed DID

    [2020-05-20 07:11:42] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:1] Set("PJSIP/Skyetel_trunk-000028b8", "CALLERID(number)=4023979800") in new stack
    [2020-05-20 07:11:42] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:2] Goto("PJSIP/Skyetel_trunk-000028b8", "from-pstn,14029733266,1") in new stack
    [2020-05-20 07:11:42] VERBOSE[7487][C-00001239] pbx_builtins.c: Goto (from-pstn,14029733266,1)
    [2020-05-20 07:11:42] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:1] Set("PJSIP/Skyetel_trunk-000028b8", "__FROM_DID=14029733266") in new stack
    [2020-05-20 07:11:42] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:2] NoOp("PJSIP/Skyetel_trunk-000028b8", "Received an unknown call with DID set to 14029733266") in new stack
    [2020-05-20 07:11:42] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:3] Goto("PJSIP/Skyetel_trunk-000028b8", "s,a2") in new stack
    [2020-05-20 07:11:42] VERBOSE[7487][C-00001239] pbx_builtins.c: Goto (from-pstn,s,2)
    [2020-05-20 07:11:42] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:2] Answer("PJSIP/Skyetel_trunk-000028b8", "") in new stack
    [2020-05-20 07:11:42] WARNING[7487][C-00001239] chan_sip.c: This function can only be used on SIP channels.
    [2020-05-20 07:11:42] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:3] Log("PJSIP/Skyetel_trunk-000028b8", "WARNING,Friendly Scanner from ") in new stack
    [2020-05-20 07:11:42] WARNING[7487][C-00001239] Ext. s: Friendly Scanner from 
    [2020-05-20 07:11:42] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:4] Wait("PJSIP/Skyetel_trunk-000028b8", "2") in new stack
    [2020-05-20 07:11:44] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:5] Playback("PJSIP/Skyetel_trunk-000028b8", "ss-noservice") in new stack
    [2020-05-20 07:11:44] VERBOSE[7487][C-00001239] file.c: <PJSIP/Skyetel_trunk-000028b8> Playing 'ss-noservice.ulaw' (language 'en')
    [2020-05-20 07:11:49] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:6] SayAlpha("PJSIP/Skyetel_trunk-000028b8", "14029733266") in new stack
    [2020-05-20 07:11:49] VERBOSE[7487][C-00001239] file.c: <PJSIP/Skyetel_trunk-000028b8> Playing 'digits/1.ulaw' (language 'en')
    [2020-05-20 07:11:50] VERBOSE[7487][C-00001239] file.c: <PJSIP/Skyetel_trunk-000028b8> Playing 'digits/4.ulaw' (language 'en')
    [2020-05-20 07:11:51] VERBOSE[7487][C-00001239] file.c: <PJSIP/Skyetel_trunk-000028b8> Playing 'digits/0.ulaw' (language 'en')
    [2020-05-20 07:11:52] VERBOSE[7487][C-00001239] file.c: <PJSIP/Skyetel_trunk-000028b8> Playing 'digits/2.ulaw' (language 'en')
    [2020-05-20 07:11:53] VERBOSE[7487][C-00001239] file.c: <PJSIP/Skyetel_trunk-000028b8> Playing 'digits/9.ulaw' (language 'en')
    [2020-05-20 07:11:53] VERBOSE[7487][C-00001239] file.c: <PJSIP/Skyetel_trunk-000028b8> Playing 'digits/7.ulaw' (language 'en')
    [2020-05-20 07:11:54] VERBOSE[7487][C-00001239] file.c: <PJSIP/Skyetel_trunk-000028b8> Playing 'digits/3.ulaw' (language 'en')
    [2020-05-20 07:11:55] VERBOSE[7487][C-00001239] file.c: <PJSIP/Skyetel_trunk-000028b8> Playing 'digits/3.ulaw' (language 'en')
    [2020-05-20 07:11:56] VERBOSE[7487][C-00001239] file.c: <PJSIP/Skyetel_trunk-000028b8> Playing 'digits/2.ulaw' (language 'en')
    [2020-05-20 07:11:57] VERBOSE[7487][C-00001239] file.c: <PJSIP/Skyetel_trunk-000028b8> Playing 'digits/6.ulaw' (language 'en')
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] file.c: <PJSIP/Skyetel_trunk-000028b8> Playing 'digits/6.ulaw' (language 'en')
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:7] Hangup("PJSIP/Skyetel_trunk-000028b8", "") in new stack
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] pbx.c: Spawn extension (from-pstn, s, 7) exited non-zero on 'PJSIP/Skyetel_trunk-000028b8'
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:1] Macro("PJSIP/Skyetel_trunk-000028b8", "hangupcall,") in new stack
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:1] GotoIf("PJSIP/Skyetel_trunk-000028b8", "1?theend") in new stack
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] pbx_builtins.c: Goto (macro-hangupcall,s,3)
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:3] ExecIf("PJSIP/Skyetel_trunk-000028b8", "0?Set(CDR(recordingfile)=)") in new stack
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:4] NoOp("PJSIP/Skyetel_trunk-000028b8", " montior file= ") in new stack
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:5] GotoIf("PJSIP/Skyetel_trunk-000028b8", "1?skipagi") in new stack
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] pbx_builtins.c: Goto (macro-hangupcall,s,7)
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:7] Hangup("PJSIP/Skyetel_trunk-000028b8", "") in new stack
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'PJSIP/Skyetel_trunk-000028b8' in macro 'hangupcall'
    [2020-05-20 07:11:58] VERBOSE[7487][C-00001239] pbx.c: Spawn extension (from-pstn, h, 1) exited non-zero on 'PJSIP/Skyetel_trunk-000028b8'
    [2020-05-20 07:12:15] VERBOSE[4606] asterisk.c: Remote UNIX connection
    

    And here is the log for a working call

    
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:1] Set("PJSIP/Skyetel_trunk-000028bd", "CALLERID(number)=4022120962") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:2] Goto("PJSIP/Skyetel_trunk-000028bd", "from-pstn,5312011927,1") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx_builtins.c: Goto (from-pstn,5312011927,1)
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:1] Set("PJSIP/Skyetel_trunk-000028bd", "__DIRECTION=INBOUND") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:2] Gosub("PJSIP/Skyetel_trunk-000028bd", "sub-record-check,s,1(in,5312011927,dontcare)") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:1] GotoIf("PJSIP/Skyetel_trunk-000028bd", "0?initialized") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:2] Set("PJSIP/Skyetel_trunk-000028bd", "__REC_STATUS=INITIALIZED") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:3] Set("PJSIP/Skyetel_trunk-000028bd", "NOW=1589977026") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:4] Set("PJSIP/Skyetel_trunk-000028bd", "__DAY=20") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:5] Set("PJSIP/Skyetel_trunk-000028bd", "__MONTH=05") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:6] Set("PJSIP/Skyetel_trunk-000028bd", "__YEAR=2020") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:7] Set("PJSIP/Skyetel_trunk-000028bd", "__TIMESTR=20200520-071706") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:8] Set("PJSIP/Skyetel_trunk-000028bd", "__FROMEXTEN=unknown") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:9] Set("PJSIP/Skyetel_trunk-000028bd", "__MON_FMT=wav") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:10] NoOp("PJSIP/Skyetel_trunk-000028bd", "Recordings initialized") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:11] ExecIf("PJSIP/Skyetel_trunk-000028bd", "0?Set(ARG3=dontcare)") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:12] Set("PJSIP/Skyetel_trunk-000028bd", "REC_POLICY_MODE_SAVE=") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:13] ExecIf("PJSIP/Skyetel_trunk-000028bd", "0?Set(REC_STATUS=NO)") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:14] GotoIf("PJSIP/Skyetel_trunk-000028bd", "2?checkaction") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx_builtins.c: Goto (sub-record-check,s,17)
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:17] GotoIf("PJSIP/Skyetel_trunk-000028bd", "1?sub-record-check,in,1") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx_builtins.c: Goto (sub-record-check,in,1)
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:1] NoOp("PJSIP/Skyetel_trunk-000028bd", "Inbound Recording Check to 5312011927") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:2] Set("PJSIP/Skyetel_trunk-000028bd", "FROMEXTEN=unknown") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:3] ExecIf("PJSIP/Skyetel_trunk-000028bd", "10?Set(FROMEXTEN=4022120962)") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:4] Gosub("PJSIP/Skyetel_trunk-000028bd", "recordcheck,1(dontcare,in,5312011927)") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:1] NoOp("PJSIP/Skyetel_trunk-000028bd", "Starting recording check against dontcare") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:2] Goto("PJSIP/Skyetel_trunk-000028bd", "dontcare") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:3] Return("PJSIP/Skyetel_trunk-000028bd", "") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:5] Return("PJSIP/Skyetel_trunk-000028bd", "") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:3] Set("PJSIP/Skyetel_trunk-000028bd", "CHANNEL(tonezone)=us") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:4] Set("PJSIP/Skyetel_trunk-000028bd", "__FROM_DID=5312011927") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:5] Set("PJSIP/Skyetel_trunk-000028bd", "returnhere=1") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:6] Gosub("PJSIP/Skyetel_trunk-000028bd", "app-blacklist-check,s,1()") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:1] GotoIf("PJSIP/Skyetel_trunk-000028bd", "0?blacklisted") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:2] Set("PJSIP/Skyetel_trunk-000028bd", "CALLED_BLACKLIST=1") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:3] Return("PJSIP/Skyetel_trunk-000028bd", "") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:7] Set("PJSIP/Skyetel_trunk-000028bd", "CDR(did)=5312011927") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:8] GotoIf("PJSIP/Skyetel_trunk-000028bd", "0?") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:9] ExecIf("PJSIP/Skyetel_trunk-000028bd", "0 ?Set(CALLERID(name)=4022120962)") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:10] Set("PJSIP/Skyetel_trunk-000028bd", "__MOHCLASS=") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:11] Set("PJSIP/Skyetel_trunk-000028bd", "__REVERSAL_REJECT=FALSE") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:12] GotoIf("PJSIP/Skyetel_trunk-000028bd", "1?post-reverse-charge") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx_builtins.c: Goto (from-pstn,5312011927,14)
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:14] NoOp("PJSIP/Skyetel_trunk-000028bd", "") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:15] Set("PJSIP/Skyetel_trunk-000028bd", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:16] Set("PJSIP/Skyetel_trunk-000028bd", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:17] Set("PJSIP/Skyetel_trunk-000028bd", "CALLERID(name-pres)=allowed_not_screened") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:18] Set("PJSIP/Skyetel_trunk-000028bd", "CALLERID(num-pres)=allowed_not_screened") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:19] NoOp("PJSIP/Skyetel_trunk-000028bd", "CallerID Entry Point") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:20] Goto("PJSIP/Skyetel_trunk-000028bd", "timeconditions,1,1") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx_builtins.c: Goto (timeconditions,1,1)
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:1] Set("PJSIP/Skyetel_trunk-000028bd", "DB(TC/1/INUSESTATE)=INUSE") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:2] Set("PJSIP/Skyetel_trunk-000028bd", "DB(TC/1/NOT_INUSESTATE)=NOT_INUSE") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:3] NoOp("PJSIP/Skyetel_trunk-000028bd", "TIMENOW: 07:17,Wed,20,May") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:4] NoOp("PJSIP/Skyetel_trunk-000028bd", "TIMEMATCHED: FALSE") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:5] GotoIfTime("PJSIP/Skyetel_trunk-000028bd", "08:00-17:00,mon-fri,*,*?truestate") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:6] GotoIf("PJSIP/Skyetel_trunk-000028bd", "0?truegoto") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:7] ExecIf("PJSIP/Skyetel_trunk-000028bd", "0?Set(DB(TC/1)=)") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:8] Set("PJSIP/Skyetel_trunk-000028bd", "DEVICE_STATE(Custom:TC1)=INUSE") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:9] ExecIf("PJSIP/Skyetel_trunk-000028bd", "0?Set(DEVICE_STATE(Custom:TCSTICKY)=INUSE)") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:10] GotoIf("PJSIP/Skyetel_trunk-000028bd", "1?ivr-1,s,1") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx_builtins.c: Goto (ivr-1,s,1)
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:1] Set("PJSIP/Skyetel_trunk-000028bd", "INVALID_LOOPCOUNT=0") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:2] Set("PJSIP/Skyetel_trunk-000028bd", "_IVR_CONTEXT_ivr-1=") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:3] Set("PJSIP/Skyetel_trunk-000028bd", "_IVR_CONTEXT=ivr-1") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:4] Set("PJSIP/Skyetel_trunk-000028bd", "__IVR_RETVM=") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:5] GotoIf("PJSIP/Skyetel_trunk-000028bd", "0?skip") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:6] Answer("PJSIP/Skyetel_trunk-000028bd", "") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:7] Set("PJSIP/Skyetel_trunk-000028bd", "IVR_MSG=custom/billing-ivr") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:8] Set("PJSIP/Skyetel_trunk-000028bd", "TIMEOUT(digit)=3") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] func_timeout.c: Digit timeout set to 3.000
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:9] ExecIf("PJSIP/Skyetel_trunk-000028bd", "1?Background(custom/billing-ivr)") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] file.c: <PJSIP/Skyetel_trunk-000028bd> Playing 'custom/billing-ivr.ulaw' (language 'en')
    [2020-05-20 07:17:19] VERBOSE[8358][C-0000123e] pbx.c: Spawn extension (ivr-1, s, 9) exited non-zero on 'PJSIP/Skyetel_trunk-000028bd'
    [2020-05-20 07:17:19] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:1] Hangup("PJSIP/Skyetel_trunk-000028bd", "") in new stack
    [2020-05-20 07:17:19] VERBOSE[8358][C-0000123e] pbx.c: Spawn extension (ivr-1, h, 1) exited non-zero on 'PJSIP/Skyetel_trunk-000028bd'
    

    The difference starts at line 5 where my failed line says
    [2020-05-20 07:11:42] VERBOSE[7487][C-00001239] pbx.c: Executing [[email protected]:2] NoOp("PJSIP/Skyetel_trunk-000028b8", "Received an unknown call with DID set to 14029733266") in new stack

    and the working one says
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:1] Set("PJSIP/Skyetel_trunk-000028bd", "__DIRECTION=INBOUND") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:2] Gosub("PJSIP/Skyetel_trunk-000028bd", "sub-record-check,s,1(in,5312011927,dontcare)") in new stack
    [2020-05-20 07:17:06] VERBOSE[8358][C-0000123e] pbx.c: Executing [[email protected]:1] GotoIf("PJSIP/Skyetel_trunk-000028bd", "0?initialized") in new stack

    etc.

    I don't see any IPs listed here, so I'm not sure where to check what IP this call is coming in on?



  • Anything in the logs from Skyetel's side?



  • 2117b5fc-4fc1-4738-b907-a8b288078779-image.png



  • Do you have any Caller ID handling? That's where the two diverge. The one sends the one call one place, the other tries to identify the caller ID.



  • @scottalanmiller said in FreePBX call not routing:

    Do you have any Caller ID handling? That's where the two diverge. The one sends the one call one place, the other tries to identify the caller ID.

    No, I shouldn't, let me double check.



  • working DID
    caa71836-d2fb-44b3-8129-f2a0c5e8c780-image.png

    Not working DID
    80eb53e4-c475-4b01-8963-a864a14fa4d0-image.png



  • Only difference is the destination, well, and the incoming DID #



  • @Dashrender said in FreePBX call not routing:

    Only difference is the destination, well, and the incoming DID #

    Anything different under Advanced or Other?



  • Also, try setting them to the same destination until it works, just in case it is a destination issue.



  • Skyetell sends an 11 digit number so basically your number with a 1 added by default unless you change it to send only 10 digits your inbound route is missing a one.

    14029733266



  • @scottalanmiller said in FreePBX call not routing:

    Also, try setting them to the same destination until it works, just in case it is a destination issue.

    No change, still "not in service"



  • @Romo said in FreePBX call not routing:

    Skyetell sends an 11 digit number so basically your number with a 1 added by default unless you change it to send only 10 digits your inbound route is missing a one.

    14029733266

    While this was not specifically the issue - it did lead me in a direction, found a change I missed on the Skyetel side - testing now.



  • @Dashrender - I haven't used Skyetel yet but do they have an inbound setting like voip.ms does? On voip.ms there is the device type under inbound settings - "IP PBX Server, Asterisk, or Softswitch" or "ATA device, IP Phone or Softphone".



  • OK anyone reading this in the future,

    Skyetel has the option to set the SIP Format as seen here. Following their instructions for use with FreePBX requires changing this to +1NPANxxxxxx from 1NPANxxxxxx, then FreePBX will drop the +1...

    In my case, since I didn't originally make this change, FreePBX wasn't dropping the 1 (It was looking for +1, didn't find it so it did nothing) and therefore my number didn't match.

    alt text



  • @syko24 said in FreePBX call not routing:

    @Dashrender - I haven't used Skyetel yet but do they have an inbound setting like voip.ms does? On voip.ms there is the device type under inbound settings - "IP PBX Server, Asterisk, or Softswitch" or "ATA device, IP Phone or Softphone".

    Not that I know of, this is the trunk settings on the Skyetel side
    de015bcb-3147-436b-ab21-3ae12db9401b-image.png

    FYI - my problem is now fixed, after I changed the SIP Format option.



  • @Dashrender said in FreePBX call not routing:

    OK anyone reading this in the future,

    Skyetel has the option to set the SIP Format as seen here. Following their instructions for use with FreePBX requires changing this to +1NPANxxxxxx from 1NPANxxxxxx, then FreePBX will drop the +1...

    In my case, since I didn't originally make this change, FreePBX wasn't dropping the 1 (It was looking for +1, didn't find it so it did nothing) and therefore my number didn't match.

    It is not their instructions. it is my instructions.

    The guidance you were given, and that is stated in my instructions, is that you want your DID to be in a clean format within your PBX.

    Skyetel, which defaults to the stupid NANPA format of 1NPANXXXXXX, gives you have no easy method built in to FreePBX to strip the 1, and thus have clean 10 digit numbers everywhere within your call flow.

    So to fix that, you tell Skyetel to set your inbound calls to an actual standard called E.164. Then you tell your trunk that it is expecting calls in that standard, and that you are in the US, by using the built in context from-pstn-e164-us. This results in the context stripping the +1 from the inbound call prior to any other processing by your PBX. Thus you only ever see 10 digit numbers in caller ID and redial history on the phones.



  • @Dashrender said in FreePBX call not routing:

    Quick googling has lead me to an IP missmatch on the Skyetel trunk, so the system is rejecting the call basically.

    Dunno WTF you searched up, but it was wrong as shit.

    Also, basic logic tells you that if the call is hitting your PBX it is impossible for it to be a firewall issue.



  • @Romo said in FreePBX call not routing:

    Skyetell sends an 11 digit number so basically your number with a 1 added by default unless you change it to send only 10 digits your inbound route is missing a one.

    14029733266

    See my previous reply, but changing it to a 10 digit number is jsut as bad as the stupid 11 digit number.

    Standards are a good thing.





  • @Dashrender if oyu are going to ignore my recommendations, then just create an any/any inbound route and point it someplace. Then you would never have had this problem.

    Of course, when you tried to specifically route the DID to something later, it woudl not have worked, as it would not match and fail to the any/any route. but meh. At least you would not have been thinking of unrelated things like firewall.



  • @JaredBusch said in FreePBX call not routing:

    @Dashrender if oyu are going to ignore my recommendations, then just create an any/any inbound route and point it someplace. Then you would never have had this problem.

    Of course, when you tried to specifically route the DID to something later, it woudl not have worked, as it would not match and fail to the any/any route. but meh. At least you would not have been thinking of unrelated things like firewall.

    I didn't ignore anything, I like your reasoning, but I had only ever setup DIDs from Skyetel one time before, and I had forgotten about that setting - but the mention of the 11 digit versus 10 reminded me of that change (your change) and I made it and life is grand.

    Thanks!


Log in to reply