IP Authentication Issue

danny2014 · January 29, 2018, 9:14pm

Hello,

I am using IP Authentication on the system below:

Incredible PBX 13-12.2 for Scientific Linux
Incredible GUI 12.0.39

When sending a call out I get the message all circuits are busy. Inbound calls work fine. I have setup everything according to the provider recommendations and have contacted them with no Luck. Please Help.

When using a register string everything works fine but we want to use IP Authentication as we do on other systems that are incredible PBX also. Thank you.

Here is the log output when sending a call out from the system.

[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [312810XXXX@from-internal:1] Macro(“SIP/1010-00000010”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:1] Set(“SIP/1010-00000010”, “TOUCH_MONITOR=1517259798.80”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:2] Set(“SIP/1010-00000010”, “AMPUSER=1010”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“SIP/1010-00000010”, “0?report”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“SIP/1010-00000010”, “1?Set(REALCALLERIDNUM=1010)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:5] Set(“SIP/1010-00000010”, “AMPUSER=1010”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“SIP/1010-00000010”, “0?limit”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:7] Set(“SIP/1010-00000010”, “AMPUSERCIDNAME=Durmic 1010”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:8] GotoIf(“SIP/1010-00000010”, “0?report”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:9] Set(“SIP/1010-00000010”, “AMPUSERCID=1010”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:10] Set(“SIP/1010-00000010”, “__DIAL_OPTIONS=tr”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:11] Set(“SIP/1010-00000010”, “CALLERID(all)=“Durmic 1010” <1010>”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:12] GotoIf(“SIP/1010-00000010”, “0?limit”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:13] ExecIf(“SIP/1010-00000010”, “1?Set(GROUP(concurrency_limit)=1010)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:14] GosubIf(“SIP/1010-00000010”, “7?sub-ccss,s,1(from-internal,312810XXXX)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-ccss:1] ExecIf(“SIP/1010-00000010”, “0?Return()”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-ccss:2] Set(“SIP/1010-00000010”, “CCSS_SETUP=TRUE”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-ccss:3] GosubIf(“SIP/1010-00000010”, “0?monitor_config,1(from-internal,312810XXXX):monitor_default,1(from-internal,312810XXXX)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [monitor_default@sub-ccss:1] GotoIf(“SIP/1010-00000010”, “0?is_exten”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [monitor_default@sub-ccss:2] StackPop(“SIP/1010-00000010”, “”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [monitor_default@sub-ccss:3] Return(“SIP/1010-00000010”, “FALSE”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:15] GotoIf(“SIP/1010-00000010”, “1?continue”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-user-callerid,s,28)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:28] Set(“SIP/1010-00000010”, “CALLERID(number)=1010”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:29] Set(“SIP/1010-00000010”, “CALLERID(name)=Durmic 1010”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:30] Set(“SIP/1010-00000010”, “CDR(cnum)=1010”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:31] Set(“SIP/1010-00000010”, “CDR(cnam)=Durmic 1010”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-user-callerid:32] Set(“SIP/1010-00000010”, “CHANNEL(language)=en”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [312810XXXX@from-internal:2] Gosub(“SIP/1010-00000010”, “sub-record-check,s,1(out,312810XXXX,dontcare)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:1] GotoIf(“SIP/1010-00000010”, “0?initialized”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:2] Set(“SIP/1010-00000010”, “__REC_STATUS=INITIALIZED”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:3] Set(“SIP/1010-00000010”, “NOW=1517259798”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:4] Set(“SIP/1010-00000010”, “__DAY=29”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:5] Set(“SIP/1010-00000010”, “__MONTH=01”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:6] Set(“SIP/1010-00000010”, “__YEAR=2018”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:7] Set(“SIP/1010-00000010”, “__TIMESTR=20180129-150318”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:8] Set(“SIP/1010-00000010”, “__FROMEXTEN=1010”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:9] Set(“SIP/1010-00000010”, “__MON_FMT=wav”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:10] NoOp(“SIP/1010-00000010”, “Recordings initialized”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:11] ExecIf(“SIP/1010-00000010”, “0?Set(ARG3=dontcare)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:12] Set(“SIP/1010-00000010”, “REC_POLICY_MODE_SAVE=”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:13] ExecIf(“SIP/1010-00000010”, “0?Set(REC_STATUS=NO)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:14] GotoIf(“SIP/1010-00000010”, “3?checkaction”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (sub-record-check,s,17)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@sub-record-check:17] GotoIf(“SIP/1010-00000010”, “1?sub-record-check,out,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (sub-record-check,out,1)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [out@sub-record-check:1] NoOp(“SIP/1010-00000010”, “Outbound Recording Check from 1010 to 312810XXXX”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [out@sub-record-check:2] Set(“SIP/1010-00000010”, “RECMODE=always”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [out@sub-record-check:3] ExecIf(“SIP/1010-00000010”, “0?Goto(routewins)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [out@sub-record-check:4] ExecIf(“SIP/1010-00000010”, “0?Goto(routewins)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [out@sub-record-check:5] Gosub(“SIP/1010-00000010”, “recordcheck,1(always,out,312810XXXX)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“SIP/1010-00000010”, “Starting recording check against always”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“SIP/1010-00000010”, “always”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (sub-record-check,recordcheck,4)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:4] NoOp(“SIP/1010-00000010”, “Detected legacy “always” entry. Mapping to “force””) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:5] Set(“SIP/1010-00000010”, “__REC_POLICY_MODE=FORCE”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:6] GotoIf(“SIP/1010-00000010”, “1?startrec”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (sub-record-check,recordcheck,16)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:16] NoOp(“SIP/1010-00000010”, “Starting recording: out, 312810XXXX”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:17] Set(“SIP/1010-00000010”, “AUDIOHOOK_INHERIT(MixMonitor)=yes”) in new stack
[2018-01-29 15:03:18] ERROR[17200][C-00000006] pbx_functions.c: Function AUDIOHOOK_INHERIT not registered
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:18] Set(“SIP/1010-00000010”, “__CALLFILENAME=out-312810XXXX-1010-20180129-150318-1517259798.80”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:19] MixMonitor(“SIP/1010-00000010”, “2018/01/29/out-312810XXXX-1010-20180129-150318-1517259798.80.wav,ai(LOCAL_MIXMON_ID),”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:20] Set(“SIP/1010-00000010”, “__MIXMON_ID=0x9ebb540”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:21] Set(“SIP/1010-00000010”, “__RECORD_ID=SIP/1010-00000010”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:22] Set(“SIP/1010-00000010”, “__REC_STATUS=RECORDING”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:23] Set(“SIP/1010-00000010”, “CDR(recordingfile)=out-312810XXXX-1010-20180129-150318-1517259798.80.wav”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [recordcheck@sub-record-check:24] Return(“SIP/1010-00000010”, “”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [out@sub-record-check:6] Return(“SIP/1010-00000010”, “”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [312810XXXX@from-internal:3] Set(“SIP/1010-00000010”, “MOHCLASS=default”) in new stack
[2018-01-29 15:03:18] VERBOSE[17201][C-00000006] app_mixmonitor.c: Begin MixMonitor Recording SIP/1010-00000010
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [312810XXXX@from-internal:4] Set(“SIP/1010-00000010”, “_NODEST=”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [312810XXXX@from-internal:5] Macro(“SIP/1010-00000010”, “dialout-trunk,19,13128104128,off”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:1] Set(“SIP/1010-00000010”, “DIAL_TRUNK=19”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:2] GosubIf(“SIP/1010-00000010”, “0?sub-pincheck,s,1()”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/1010-00000010”, “0?disabletrunk,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:4] Set(“SIP/1010-00000010”, “DIAL_NUMBER=13128104128”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:5] Set(“SIP/1010-00000010”, “DIAL_TRUNK_OPTIONS=tr”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:6] Set(“SIP/1010-00000010”, “OUTBOUND_GROUP=OUT_19”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/1010-00000010”, “1?nomax”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-dialout-trunk,s,9)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/1010-00000010”, “0?skipoutcid”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:10] Set(“SIP/1010-00000010”, “DIAL_TRUNK_OPTIONS=”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:11] Macro(“SIP/1010-00000010”, “outbound-callerid,19”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:1] ExecIf(“SIP/1010-00000010”, “0?Set(CALLERPRES()=)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:2] ExecIf(“SIP/1010-00000010”, “0?Set(REALCALLERIDNUM=1010)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:3] GotoIf(“SIP/1010-00000010”, “1?normcid”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-outbound-callerid,s,6)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:6] Set(“SIP/1010-00000010”, “USEROUTCID=3124732721”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:7] Set(“SIP/1010-00000010”, “EMERGENCYCID=”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:8] Set(“SIP/1010-00000010”, “TRUNKOUTCID=”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:9] GotoIf(“SIP/1010-00000010”, “1?trunkcid”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-outbound-callerid,s,14)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:14] ExecIf(“SIP/1010-00000010”, “0?Set(CALLERID(all)=)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf(“SIP/1010-00000010”, “1?Set(CALLERID(all)=3124732721)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:16] ExecIf(“SIP/1010-00000010”, “0?Set(CALLERID(all)=)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:17] ExecIf(“SIP/1010-00000010”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:18] Set(“SIP/1010-00000010”, “CDR(outbound_cnum)=3124732721”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:19] Set(“SIP/1010-00000010”, “CDR(outbound_cnam)=”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:12] GosubIf(“SIP/1010-00000010”, “0?sub-flp-19,s,1()”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:13] Set(“SIP/1010-00000010”, “OUTNUM=13128104128”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:14] Set(“SIP/1010-00000010”, “custom=SIP/5225256244GW1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:15] ExecIf(“SIP/1010-00000010”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:16] ExecIf(“SIP/1010-00000010”, “0?Set(DIAL_TRUNK_OPTIONS=M(confirm))”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:17] Macro(“SIP/1010-00000010”, “dialout-trunk-predial-hook,”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/1010-00000010”, “”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/1010-00000010”, “0?bypass,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:19] ExecIf(“SIP/1010-00000010”, “1?Set(CONNECTEDLINE(num,i)=13128104128)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:20] ExecIf(“SIP/1010-00000010”, “1?Set(CONNECTEDLINE(name,i)=CID:3124732721)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:21] GotoIf(“SIP/1010-00000010”, “0?customtrunk”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:22] Dial(“SIP/1010-00000010”, “SIP/5225256244GW1/13128104128,300,”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] netsock2.c: Using SIP RTP TOS bits 184
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] netsock2.c: Using SIP RTP CoS mark 5
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] app_dial.c: Called SIP/5225256244GW1/13128104128
[2018-01-29 15:03:18] WARNING[12716][C-00000006] chan_sip.c: Received response: “Forbidden” from ‘sip:[email protected]:5063;tag=as65f77092’
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] app_dial.c: Everyone is busy/congested at this time (1:0/0/1)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:23] NoOp(“SIP/1010-00000010”, “Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 21”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:24] GotoIf(“SIP/1010-00000010”, “0?continue,1:s-CHANUNAVAIL,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set(“SIP/1010-00000010”, “RC=21”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto(“SIP/1010-00000010”, “21,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-dialout-trunk,21,1)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [21@macro-dialout-trunk:1] Goto(“SIP/1010-00000010”, “continue,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-dialout-trunk,continue,1)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [continue@macro-dialout-trunk:1] NoOp(“SIP/1010-00000010”, “TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 21 - failing through to other trunks”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [continue@macro-dialout-trunk:2] Set(“SIP/1010-00000010”, “CALLERID(number)=1010”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [312810XXXX@from-internal:6] Macro(“SIP/1010-00000010”, “dialout-trunk,20,13128104128,off”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:1] Set(“SIP/1010-00000010”, “DIAL_TRUNK=20”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:2] GosubIf(“SIP/1010-00000010”, “0?sub-pincheck,s,1()”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/1010-00000010”, “0?disabletrunk,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:4] Set(“SIP/1010-00000010”, “DIAL_NUMBER=13128104128”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:5] Set(“SIP/1010-00000010”, “DIAL_TRUNK_OPTIONS=tr”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:6] Set(“SIP/1010-00000010”, “OUTBOUND_GROUP=OUT_20”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/1010-00000010”, “1?nomax”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-dialout-trunk,s,9)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/1010-00000010”, “0?skipoutcid”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:10] Set(“SIP/1010-00000010”, “DIAL_TRUNK_OPTIONS=”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:11] Macro(“SIP/1010-00000010”, “outbound-callerid,20”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:1] ExecIf(“SIP/1010-00000010”, “0?Set(CALLERPRES()=)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:2] ExecIf(“SIP/1010-00000010”, “0?Set(REALCALLERIDNUM=1010)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:3] GotoIf(“SIP/1010-00000010”, “1?normcid”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-outbound-callerid,s,6)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:6] Set(“SIP/1010-00000010”, “USEROUTCID=3124732721”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:7] Set(“SIP/1010-00000010”, “EMERGENCYCID=”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:8] Set(“SIP/1010-00000010”, “TRUNKOUTCID=”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:9] GotoIf(“SIP/1010-00000010”, “1?trunkcid”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-outbound-callerid,s,14)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:14] ExecIf(“SIP/1010-00000010”, “0?Set(CALLERID(all)=)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf(“SIP/1010-00000010”, “1?Set(CALLERID(all)=3124732721)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:16] ExecIf(“SIP/1010-00000010”, “0?Set(CALLERID(all)=)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:17] ExecIf(“SIP/1010-00000010”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:18] Set(“SIP/1010-00000010”, “CDR(outbound_cnum)=3124732721”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outbound-callerid:19] Set(“SIP/1010-00000010”, “CDR(outbound_cnam)=”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:12] GosubIf(“SIP/1010-00000010”, “0?sub-flp-20,s,1()”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:13] Set(“SIP/1010-00000010”, “OUTNUM=13128104128”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:14] Set(“SIP/1010-00000010”, “custom=SIP/5225256244GW2”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:15] ExecIf(“SIP/1010-00000010”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:16] ExecIf(“SIP/1010-00000010”, “0?Set(DIAL_TRUNK_OPTIONS=M(confirm))”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:17] Macro(“SIP/1010-00000010”, “dialout-trunk-predial-hook,”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/1010-00000010”, “”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/1010-00000010”, “0?bypass,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:19] ExecIf(“SIP/1010-00000010”, “1?Set(CONNECTEDLINE(num,i)=13128104128)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:20] ExecIf(“SIP/1010-00000010”, “1?Set(CONNECTEDLINE(name,i)=CID:3124732721)”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:21] GotoIf(“SIP/1010-00000010”, “0?customtrunk”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:22] Dial(“SIP/1010-00000010”, “SIP/5225256244GW2/13128104128,300,”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] netsock2.c: Using SIP RTP TOS bits 184
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] netsock2.c: Using SIP RTP CoS mark 5
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] app_dial.c: Called SIP/5225256244GW2/13128104128
[2018-01-29 15:03:18] NOTICE[12716][C-00000006] chan_sip.c: Failed to authenticate on INVITE to ‘sip:[email protected]:5063;tag=as442e6783’
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] app_dial.c: SIP/5225256244GW2-00000012 is circuit-busy
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] app_dial.c: Everyone is busy/congested at this time (1:0/1/0)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:23] NoOp(“SIP/1010-00000010”, “Dial failed for some reason with DIALSTATUS = CONGESTION and HANGUPCAUSE = 21”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-dialout-trunk:24] GotoIf(“SIP/1010-00000010”, “0?continue,1:s-CONGESTION,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-dialout-trunk,s-CONGESTION,1)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s-CONGESTION@macro-dialout-trunk:1] Set(“SIP/1010-00000010”, “RC=21”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s-CONGESTION@macro-dialout-trunk:2] Goto(“SIP/1010-00000010”, “21,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-dialout-trunk,21,1)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [21@macro-dialout-trunk:1] Goto(“SIP/1010-00000010”, “continue,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx_builtins.c: Goto (macro-dialout-trunk,continue,1)
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [continue@macro-dialout-trunk:1] NoOp(“SIP/1010-00000010”, “TRUNK Dial failed due to CONGESTION HANGUPCAUSE: 21 - failing through to other trunks”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [continue@macro-dialout-trunk:2] Set(“SIP/1010-00000010”, “CALLERID(number)=1010”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [312810XXXX@from-internal:7] Macro(“SIP/1010-00000010”, “outisbusy,”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outisbusy:1] Progress(“SIP/1010-00000010”, “”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outisbusy:2] GotoIf(“SIP/1010-00000010”, “0?emergency,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outisbusy:3] GotoIf(“SIP/1010-00000010”, “0?intracompany,1”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outisbusy:4] Playback(“SIP/1010-00000010”, “all-circuits-busy-now&pls-try-call-later, noanswer”) in new stack
[2018-01-29 15:03:18] VERBOSE[17200][C-00000006] file.c: <SIP/1010-00000010> Playing ‘all-circuits-busy-now.gsm’ (language ‘en’)
[2018-01-29 15:03:20] VERBOSE[17200][C-00000006] file.c: <SIP/1010-00000010> Playing ‘pls-try-call-later.gsm’ (language ‘en’)
[2018-01-29 15:03:22] VERBOSE[17200][C-00000006] pbx.c: Executing [s@macro-outisbusy:5] Congestion(“SIP/1010-00000010”, “20”) in new stack
[2018-01-29 15:03:22] VERBOSE[17200][C-00000006] app_macro.c: Spawn extension (macro-outisbusy, s, 5) exited non-zero on ‘SIP/1010-00000010’ in macro ‘outisbusy’
[2018-01-29 15:03:22] VERBOSE[17200][C-00000006] pbx.c: Spawn extension (from-internal, 312810XXXX, 7) exited non-zero on ‘SIP/1010-00000010’
[2018-01-29 15:03:22] VERBOSE[17200][C-00000006] pbx.c: Executing [h@from-internal:1] Hangup(“SIP/1010-00000010”, “”) in new stack
[2018-01-29 15:03:22] VERBOSE[17200][C-00000006] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/1010-00000010’
[2018-01-29 15:03:22] VERBOSE[17201][C-00000006] app_mixmonitor.c: MixMonitor close filestream (mixed)
[2018-01-29 15:03:22] VERBOSE[17201][C-00000006] app_mixmonitor.c: End MixMonitor Recording SIP/1010-00000010

cynjut · January 29, 2018, 9:30pm

Does your provider support IP Authentication? This line implies they don’t or they have a different IP than you are using.

danny2014 · January 30, 2018, 12:05am

Hello,
After fixing that for the secondary trunk calls do work now, however, i have a first trunk that was all correct info and I am not sure why the call would not dial out through it if the secondary trunk info was incorrect by mistake.

I would think the trunks work independently of one another. Thanks for pointing out this mistake anyway.

cynjut · January 30, 2018, 4:42pm

In general, trunks do work independently. Since you are now connecting through the secondary, there must be a configuration problem in your primary. I had a similar problem once with Voip Innovations - one of their servers was on 99.99.13.99 and one was on 99.99.14.98. For some reason, the 13 and the 14 just didn’t penetrate my brain, and I used ‘14’ for both. The ‘13’ one would never connect and it perplexed me for something like a year. I’m will to guess that you’re up against something that’s almost as transparent.

system · January 30, 2019, 4:42pm

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