IVR Limited Direct Dial Extension is not working

re: FreePBX 13.0.197.22
PBX Firmware: 10.13.66-22

Someone calling my IVR and was able to make outside calls. I need to stop this.

My IVR Direct Dial By Extension >> set to a directory “Client Directory:” which contains ext 1001, 1002, 1003

Setting >> advance settings >> Asterisk Dial Options is set to blank

Setting >> advance settings >> Asterisk Outbound Trunk Dial Option is is set to blank

Admin >> Config Edit >> Extension_custom.conf is blank

I can not duplicate the issue but I know its possible because the sip trunk cost is higher the normal
If I set IVR Direct Dial to Disable the problem seems to stop

Here’s my CDR log for a particular call
:

the last 3 digit 690 id the the number the hacker is calling

The number 16417937017 is the number it was calling, Sometime the number 16417937018, 16417937019, 16417937080, etc

On the CRD, under context I see macro-dialout-trunk and restrictedroute-afe2a63c5f8f5da9b3b8c64b2dc84cc1. But not sure where the files is to check the content

Appreciate an help.

I think you will find that you installed the commercially licensed “restricted routes” module , that code is obfuscated so only Sangoma can help you with that one.

I have Extension Routing installed. Is the the same as restrict route that you mention
if not, how can I confirm Restrict route is installed?

Thanks

They are effectively the same.

A good idea but not relevant to this problem.

That’s strange; it would normally be ‘r’ if you are not allowing any DTMF transfers. Do you have an extension 1031 on your system? Reachable from IVR? If not, what routes to that extension? What does it show for Dial Options?

Do you have the option ‘Disallow transfer features for inbound callers’ in your Advanced settings? If so, is it turned on?

If you don’t need to transfer by DTMF, in Admin → Feature Codes, disable In-Call Asterisk Attended Transfer and In-Call Asterisk Blind Transfer.

If you still have trouble, post the Asterisk log for a hacker-initiated call.

I appreciate you help,

Yes, I have extension 1031
Extension 1031 is reachable via IVR.
IVR Direct Dial by Extension is set to a directory that has ext 1031
Direct Dial by Extension is currently disable to stop hacker
Disallow transfer features for inbound callers is already set to YES

In-Call Asterisk Attended Transfer and In-Call Asterisk Blind Transfer is not enable and confirmed
While I’m on the phone, i Press “##” and “*2” and nothign happen. My users use the default softkeys button on the phone to Transfer / Blind

Log.
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [16054752108@from-internal:1] Macro(“PJSIP/1031-00005109”, “user-callerid,LIMIT”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/1031-00005109”, “TOUCH_MONITOR=1581106289.168617”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/1031-00005109”, “AMPUSER=1031”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“PJSIP/1031-00005109”, “0?report”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“PJSIP/1031-00005109”, “1?Set(REALCALLERIDNUM=1031)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/1031-00005109”, “AMPUSER=1031”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“PJSIP/1031-00005109”, “0?limit”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:7] Set(“PJSIP/1031-00005109”, “AMPUSERCIDNAME=Tammy Tolbert”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:8] ExecIf(“PJSIP/1031-00005109”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:9] GotoIf(“PJSIP/1031-00005109”, “0?report”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:10] Set(“PJSIP/1031-00005109”, “AMPUSERCID=1031”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:11] Set(“PJSIP/1031-00005109”, “__DIAL_OPTIONS=”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:12] Set(“PJSIP/1031-00005109”, “CALLERID(all)=“Susan Garbert” <1031>”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:13] GotoIf(“PJSIP/1031-00005109”, “0?limit”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:14] ExecIf(“PJSIP/1031-00005109”, “1?Set(GROUP(concurrency_limit)=1031)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:15] ExecIf(“PJSIP/1031-00005109”, “0?Set(CHANNEL(language)=)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:16] NoOp(“PJSIP/1031-00005109”, “Macro Depth is 1”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:17] GotoIf(“PJSIP/1031-00005109”, “1?report2:macroerror”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx_builtins.c: Goto (macro-user-callerid,s,18)
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:18] GotoIf(“PJSIP/1031-00005109”, “1?continue”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx_builtins.c: Goto (macro-user-callerid,s,37)
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:37] Set(“PJSIP/1031-00005109”, “CALLERID(number)=1031”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:38] Set(“PJSIP/1031-00005109”, “CALLERID(name)=Susan Garbert”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:39] GotoIf(“PJSIP/1031-00005109”, “0?cnum”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:40] Set(“PJSIP/1031-00005109”, “CDR(cnam)=Susan Garbert”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:41] Set(“PJSIP/1031-00005109”, “CDR(cnum)=1031”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-user-callerid:42] Set(“PJSIP/1031-00005109”, “CHANNEL(language)=en”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [16054752108@from-internal:2] Set(“PJSIP/1031-00005109”, “ROUTEUSER=1031”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [16054752108@from-internal:3] Set(“PJSIP/1031-00005109”, “ROUTEUSER=1031”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [16054752108@from-internal:4] GotoIf(“PJSIP/1031-00005109”, “1?notblind”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx_builtins.c: Goto (from-internal,16054752108,7)
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [16054752108@from-internal:7] GotoIf(“PJSIP/1031-00005109”, “1?restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3,16054752108,2:outbound-allroutes,16054752108,2”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx_builtins.c: Goto (restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3,16054752108,2)
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [16054752108@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:2] Gosub(“PJSIP/1031-00005109”, “sub-record-check,s,1(out,16054752108,dontcare)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:1] GotoIf(“PJSIP/1031-00005109”, “0?initialized”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:2] Set(“PJSIP/1031-00005109”, “__REC_STATUS=INITIALIZED”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:3] Set(“PJSIP/1031-00005109”, “NOW=1581106289”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:4] Set(“PJSIP/1031-00005109”, “__DAY=07”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:5] Set(“PJSIP/1031-00005109”, “__MONTH=02”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:6] Set(“PJSIP/1031-00005109”, “__YEAR=2020”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:7] Set(“PJSIP/1031-00005109”, “__TIMESTR=20200207-121129”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:8] Set(“PJSIP/1031-00005109”, “__FROMEXTEN=1031”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:9] Set(“PJSIP/1031-00005109”, “__MON_FMT=wav”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:10] NoOp(“PJSIP/1031-00005109”, “Recordings initialized”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:11] ExecIf(“PJSIP/1031-00005109”, “0?Set(ARG3=dontcare)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:12] Set(“PJSIP/1031-00005109”, “REC_POLICY_MODE_SAVE=”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:13] ExecIf(“PJSIP/1031-00005109”, “0?Set(REC_STATUS=NO)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:14] GotoIf(“PJSIP/1031-00005109”, “3?checkaction”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx_builtins.c: Goto (sub-record-check,s,17)
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@sub-record-check:17] GotoIf(“PJSIP/1031-00005109”, “1?sub-record-check,out,1”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx_builtins.c: Goto (sub-record-check,out,1)
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [out@sub-record-check:1] NoOp(“PJSIP/1031-00005109”, “Outbound Recording Check from 1031 to 16054752108”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [out@sub-record-check:2] Set(“PJSIP/1031-00005109”, “RECMODE=dontcare”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [out@sub-record-check:3] ExecIf(“PJSIP/1031-00005109”, “1?Goto(routewins)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx_builtins.c: Goto (sub-record-check,out,7)
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [out@sub-record-check:7] Gosub(“PJSIP/1031-00005109”, “recordcheck,1(dontcare,out,16054752108)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/1031-00005109”, “Starting recording check against dontcare”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/1031-00005109”, “dontcare”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“PJSIP/1031-00005109”, “”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [out@sub-record-check:8] Return(“PJSIP/1031-00005109”, “”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [16054752108@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:3] ExecIf(“PJSIP/1031-00005109”, “0 ?Set(CDR(accountcode)=)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [16054752108@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:4] Set(“PJSIP/1031-00005109”, “MOHCLASS=default”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [16054752108@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:5] Set(“PJSIP/1031-00005109”, “_NODEST=”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [16054752108@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:6] Macro(“PJSIP/1031-00005109”, “dialout-trunk,3,16054752108,off”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:1] Set(“PJSIP/1031-00005109”, “DIAL_TRUNK=3”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf(“PJSIP/1031-00005109”, “0?Set(DIAL_OPTIONS=)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf(“PJSIP/1031-00005109”, “0?sub-pincheck,s,1()”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:4] GotoIf(“PJSIP/1031-00005109”, “0?disabletrunk,1”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:5] Set(“PJSIP/1031-00005109”, “DIAL_NUMBER=16054752108”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:6] Set(“PJSIP/1031-00005109”, “DIAL_TRUNK_OPTIONS=”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:7] Set(“PJSIP/1031-00005109”, “OUTBOUND_GROUP=OUT_3”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:8] Set(“PJSIP/1031-00005109”, “DIAL_TRUNK_OPTIONS=”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:9] GotoIf(“PJSIP/1031-00005109”, “1?nomax”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx_builtins.c: Goto (macro-dialout-trunk,s,11)
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:11] GotoIf(“PJSIP/1031-00005109”, “0?skipoutcid”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:12] Macro(“PJSIP/1031-00005109”, “outbound-callerid,3”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:1] ExecIf(“PJSIP/1031-00005109”, “0?Set(CALLERPRES(name-pres)=)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:2] ExecIf(“PJSIP/1031-00005109”, “0?Set(CALLERPRES(num-pres)=)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:3] ExecIf(“PJSIP/1031-00005109”, “0?Set(REALCALLERIDNUM=1031)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf(“PJSIP/1031-00005109”, “0?Set(AMPUSER=1031)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:5] GotoIf(“PJSIP/1031-00005109”, “1?normcid”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx_builtins.c: Goto (macro-outbound-callerid,s,9)
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:9] Set(“PJSIP/1031-00005109”, “USEROUTCID=“Burlingame Construction”<5551113690>”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:10] Set(“PJSIP/1031-00005109”, “EMERGENCYCID=”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:11] Set(“PJSIP/1031-00005109”, “TRUNKOUTCID=”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:12] GotoIf(“PJSIP/1031-00005109”, “1?trunkcid”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx_builtins.c: Goto (macro-outbound-callerid,s,18)
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:18] ExecIf(“PJSIP/1031-00005109”, “0?Set(CALLERID(all)=)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:19] ExecIf(“PJSIP/1031-00005109”, “1?Set(CALLERID(all)=“Burlingame Construction”<5551113690>)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:20] ExecIf(“PJSIP/1031-00005109”, “0?Set(CALLERID(all)=)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:21] ExecIf(“PJSIP/1031-00005109”, “0?Set(CALLERPRES(name-pres)=prohib_passed_screen)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf(“PJSIP/1031-00005109”, “0?Set(CALLERPRES(num-pres)=prohib_passed_screen)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:23] Set(“PJSIP/1031-00005109”, “CDR(outbound_cnum)=5551113690”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-outbound-callerid:24] Set(“PJSIP/1031-00005109”, “CDR(outbound_cnam)=Burlingame Construction”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:13] GosubIf(“PJSIP/1031-00005109”, “0?sub-flp-3,s,1()”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:14] Set(“PJSIP/1031-00005109”, “OUTNUM=16054752108”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:15] Set(“PJSIP/1031-00005109”, “custom=SIP/voipms-outbound-c2”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:16] ExecIf(“PJSIP/1031-00005109”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf(“PJSIP/1031-00005109”, “0?Set(DIAL_TRUNK_OPTIONS=M(confirm))”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:18] Macro(“PJSIP/1031-00005109”, “dialout-trunk-predial-hook,”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“PJSIP/1031-00005109”, “”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:19] GotoIf(“PJSIP/1031-00005109”, “0?bypass,1”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:20] ExecIf(“PJSIP/1031-00005109”, “1?Set(CONNECTEDLINE(num,i)=16054752108)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:21] ExecIf(“PJSIP/1031-00005109”, “1?Set(CONNECTEDLINE(name,i)=CID:5551113690)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:22] ExecIf(“PJSIP/1031-00005109”, “0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)5551113690)”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:23] GotoIf(“PJSIP/1031-00005109”, “0?customtrunk”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] pbx.c: Executing [s@macro-dialout-trunk:24] Dial(“PJSIP/1031-00005109”, “SIP/voipms-outbound-c2/16054752108,300,”) in new stack
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] netsock2.c: Using SIP RTP TOS bits 184
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] netsock2.c: Using SIP RTP CoS mark 5
[2020-02-07 12:11:29] VERBOSE[30147][C-000094bb] app_dial.c: Called SIP/voipms-outbound-c2/16054752108
[2020-02-07 12:11:39] VERBOSE[30147][C-000094bb] app_dial.c: SIP/voipms-outbound-c2-0000dadf answered PJSIP/1031-00005109
[2020-02-07 12:11:39] VERBOSE[30149][C-000094bb] bridge_channel.c: Channel SIP/voipms-outbound-c2-0000dadf joined ‘simple_bridge’ basic-bridge
[2020-02-07 12:11:39] VERBOSE[30147][C-000094bb] bridge_channel.c: Channel PJSIP/1031-00005109 joined ‘simple_bridge’ basic-bridge

[2020-02-07 12:11:40] VERBOSE[32561] res_pjsip/pjsip_configuration.c: Endpoint 1031 is now Reachable
[2020-02-07 12:11:40] VERBOSE[32561] res_pjsip/pjsip_options.c: Contact 1031/sip:[email protected]:41822 is now Reachable. RTT: 259.087 msec
[2020-02-07 12:11:46] VERBOSE[30147][C-000094bb] bridge_channel.c: Channel PJSIP/1031-00005109 left ‘simple_bridge’ basic-bridge
[2020-02-07 12:11:46] VERBOSE[30147][C-000094bb] app_macro.c: Spawn extension (macro-dialout-trunk, s, 24) exited non-zero on ‘PJSIP/1031-00005109’ in macro ‘dialout-trunk’
[2020-02-07 12:11:46] VERBOSE[30147][C-000094bb] pbx.c: Spawn extension (restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3, 16054752108, 6) exited non-zero on ‘PJSIP/1031-00005109’
[2020-02-07 12:11:46] VERBOSE[30147][C-000094bb] pbx.c: Executing [h@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:1] Hangup(“PJSIP/1031-00005109”, “”) in new stack
[2020-02-07 12:11:46] VERBOSE[30147][C-000094bb] pbx.c: Spawn extension (restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3, h, 1) exited non-zero on ‘PJSIP/1031-00005109’
[2020-02-07 12:11:46] VERBOSE[30149][C-000094bb] bridge_channel.c: Channel SIP/voipms-outbound-c2-0000dadf left ‘simple_bridge’ basic-bridge
[2020-02-07 12:11:51] VERBOSE[22637] pbx_variables.c: Setting global variable ‘SIPDOMAIN’ to ‘pbx1.domain.com
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [16417930727@from-internal:1] Macro(“PJSIP/1031-0000510a”, “user-callerid,LIMIT”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/1031-0000510a”, “TOUCH_MONITOR=1581106311.168619”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/1031-0000510a”, “AMPUSER=1031”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“PJSIP/1031-0000510a”, “0?report”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“PJSIP/1031-0000510a”, “1?Set(REALCALLERIDNUM=1031)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/1031-0000510a”, “AMPUSER=1031”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“PJSIP/1031-0000510a”, “0?limit”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:7] Set(“PJSIP/1031-0000510a”, “AMPUSERCIDNAME=Susan Garbert”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:8] ExecIf(“PJSIP/1031-0000510a”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:9] GotoIf(“PJSIP/1031-0000510a”, “0?report”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:10] Set(“PJSIP/1031-0000510a”, “AMPUSERCID=1031”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:11] Set(“PJSIP/1031-0000510a”, “__DIAL_OPTIONS=”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:12] Set(“PJSIP/1031-0000510a”, “CALLERID(all)=“Susan Garbert” <1031>”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:13] GotoIf(“PJSIP/1031-0000510a”, “0?limit”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:14] ExecIf(“PJSIP/1031-0000510a”, “1?Set(GROUP(concurrency_limit)=1031)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:15] ExecIf(“PJSIP/1031-0000510a”, “0?Set(CHANNEL(language)=)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:16] NoOp(“PJSIP/1031-0000510a”, “Macro Depth is 1”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:17] GotoIf(“PJSIP/1031-0000510a”, “1?report2:macroerror”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx_builtins.c: Goto (macro-user-callerid,s,18)
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:18] GotoIf(“PJSIP/1031-0000510a”, “1?continue”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx_builtins.c: Goto (macro-user-callerid,s,37)
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:37] Set(“PJSIP/1031-0000510a”, “CALLERID(number)=1031”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:38] Set(“PJSIP/1031-0000510a”, “CALLERID(name)=Susan Garbert”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:39] GotoIf(“PJSIP/1031-0000510a”, “0?cnum”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:40] Set(“PJSIP/1031-0000510a”, “CDR(cnam)=Susan Garbert”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:41] Set(“PJSIP/1031-0000510a”, “CDR(cnum)=1031”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-user-callerid:42] Set(“PJSIP/1031-0000510a”, “CHANNEL(language)=en”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [16417930727@from-internal:2] Set(“PJSIP/1031-0000510a”, “ROUTEUSER=1031”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [16417930727@from-internal:3] Set(“PJSIP/1031-0000510a”, “ROUTEUSER=1031”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [16417930727@from-internal:4] GotoIf(“PJSIP/1031-0000510a”, “1?notblind”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx_builtins.c: Goto (from-internal,16417930727,7)
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [16417930727@from-internal:7] GotoIf(“PJSIP/1031-0000510a”, “1?restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3,16417930727,2:outbound-allroutes,16417930727,2”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx_builtins.c: Goto (restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3,16417930727,2)
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [16417930727@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:2] Gosub(“PJSIP/1031-0000510a”, “sub-record-check,s,1(out,16417930727,dontcare)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:1] GotoIf(“PJSIP/1031-0000510a”, “0?initialized”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:2] Set(“PJSIP/1031-0000510a”, “__REC_STATUS=INITIALIZED”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:3] Set(“PJSIP/1031-0000510a”, “NOW=1581106311”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:4] Set(“PJSIP/1031-0000510a”, “__DAY=07”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:5] Set(“PJSIP/1031-0000510a”, “__MONTH=02”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:6] Set(“PJSIP/1031-0000510a”, “__YEAR=2020”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:7] Set(“PJSIP/1031-0000510a”, “__TIMESTR=20200207-121151”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:8] Set(“PJSIP/1031-0000510a”, “__FROMEXTEN=1031”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:9] Set(“PJSIP/1031-0000510a”, “__MON_FMT=wav”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:10] NoOp(“PJSIP/1031-0000510a”, “Recordings initialized”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:11] ExecIf(“PJSIP/1031-0000510a”, “0?Set(ARG3=dontcare)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:12] Set(“PJSIP/1031-0000510a”, “REC_POLICY_MODE_SAVE=”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:13] ExecIf(“PJSIP/1031-0000510a”, “0?Set(REC_STATUS=NO)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:14] GotoIf(“PJSIP/1031-0000510a”, “3?checkaction”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx_builtins.c: Goto (sub-record-check,s,17)
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@sub-record-check:17] GotoIf(“PJSIP/1031-0000510a”, “1?sub-record-check,out,1”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx_builtins.c: Goto (sub-record-check,out,1)
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [out@sub-record-check:1] NoOp(“PJSIP/1031-0000510a”, “Outbound Recording Check from 1031 to 16417930727”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [out@sub-record-check:2] Set(“PJSIP/1031-0000510a”, “RECMODE=dontcare”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [out@sub-record-check:3] ExecIf(“PJSIP/1031-0000510a”, “1?Goto(routewins)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx_builtins.c: Goto (sub-record-check,out,7)
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [out@sub-record-check:7] Gosub(“PJSIP/1031-0000510a”, “recordcheck,1(dontcare,out,16417930727)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/1031-0000510a”, “Starting recording check against dontcare”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/1031-0000510a”, “dontcare”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“PJSIP/1031-0000510a”, “”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [out@sub-record-check:8] Return(“PJSIP/1031-0000510a”, “”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [16417930727@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:3] ExecIf(“PJSIP/1031-0000510a”, “0 ?Set(CDR(accountcode)=)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [16417930727@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:4] Set(“PJSIP/1031-0000510a”, “MOHCLASS=default”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [16417930727@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:5] Set(“PJSIP/1031-0000510a”, “_NODEST=”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [16417930727@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:6] Macro(“PJSIP/1031-0000510a”, “dialout-trunk,3,16417930727,off”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:1] Set(“PJSIP/1031-0000510a”, “DIAL_TRUNK=3”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf(“PJSIP/1031-0000510a”, “0?Set(DIAL_OPTIONS=)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf(“PJSIP/1031-0000510a”, “0?sub-pincheck,s,1()”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:4] GotoIf(“PJSIP/1031-0000510a”, “0?disabletrunk,1”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:5] Set(“PJSIP/1031-0000510a”, “DIAL_NUMBER=16417930727”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:6] Set(“PJSIP/1031-0000510a”, “DIAL_TRUNK_OPTIONS=”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:7] Set(“PJSIP/1031-0000510a”, “OUTBOUND_GROUP=OUT_3”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:8] Set(“PJSIP/1031-0000510a”, “DIAL_TRUNK_OPTIONS=”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:9] GotoIf(“PJSIP/1031-0000510a”, “1?nomax”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx_builtins.c: Goto (macro-dialout-trunk,s,11)
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:11] GotoIf(“PJSIP/1031-0000510a”, “0?skipoutcid”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:12] Macro(“PJSIP/1031-0000510a”, “outbound-callerid,3”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:1] ExecIf(“PJSIP/1031-0000510a”, “0?Set(CALLERPRES(name-pres)=)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:2] ExecIf(“PJSIP/1031-0000510a”, “0?Set(CALLERPRES(num-pres)=)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:3] ExecIf(“PJSIP/1031-0000510a”, “0?Set(REALCALLERIDNUM=1031)”) in new stack
[2020-02-07 12:11:51] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf(“PJSIP/1031-0000510a”, “0?Set(AMPUSER=1031)”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:5] GotoIf(“PJSIP/1031-0000510a”, “1?normcid”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx_builtins.c: Goto (macro-outbound-callerid,s,9)
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:9] Set(“PJSIP/1031-0000510a”, “USEROUTCID=“Burlingame Construction”<5551113690>”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:10] Set(“PJSIP/1031-0000510a”, “EMERGENCYCID=”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:11] Set(“PJSIP/1031-0000510a”, “TRUNKOUTCID=”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:12] GotoIf(“PJSIP/1031-0000510a”, “1?trunkcid”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx_builtins.c: Goto (macro-outbound-callerid,s,18)
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:18] ExecIf(“PJSIP/1031-0000510a”, “0?Set(CALLERID(all)=)”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:19] ExecIf(“PJSIP/1031-0000510a”, “1?Set(CALLERID(all)=“Burlingame Construction”<5551113690>)”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:20] ExecIf(“PJSIP/1031-0000510a”, “0?Set(CALLERID(all)=)”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:21] ExecIf(“PJSIP/1031-0000510a”, “0?Set(CALLERPRES(name-pres)=prohib_passed_screen)”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf(“PJSIP/1031-0000510a”, “0?Set(CALLERPRES(num-pres)=prohib_passed_screen)”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:23] Set(“PJSIP/1031-0000510a”, “CDR(outbound_cnum)=5551113690”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-outbound-callerid:24] Set(“PJSIP/1031-0000510a”, “CDR(outbound_cnam)=Burlingame Construction”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:13] GosubIf(“PJSIP/1031-0000510a”, “0?sub-flp-3,s,1()”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:14] Set(“PJSIP/1031-0000510a”, “OUTNUM=16417930727”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:15] Set(“PJSIP/1031-0000510a”, “custom=SIP/voipms-outbound-c2”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:16] ExecIf(“PJSIP/1031-0000510a”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf(“PJSIP/1031-0000510a”, “0?Set(DIAL_TRUNK_OPTIONS=M(confirm))”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:18] Macro(“PJSIP/1031-0000510a”, “dialout-trunk-predial-hook,”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“PJSIP/1031-0000510a”, “”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:19] GotoIf(“PJSIP/1031-0000510a”, “0?bypass,1”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:20] ExecIf(“PJSIP/1031-0000510a”, “1?Set(CONNECTEDLINE(num,i)=16417930727)”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:21] ExecIf(“PJSIP/1031-0000510a”, “1?Set(CONNECTEDLINE(name,i)=CID:5551113690)”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:22] ExecIf(“PJSIP/1031-0000510a”, “0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)5551113690)”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:23] GotoIf(“PJSIP/1031-0000510a”, “0?customtrunk”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] pbx.c: Executing [s@macro-dialout-trunk:24] Dial(“PJSIP/1031-0000510a”, “SIP/voipms-outbound-c2/16417930727,300,”) in new stack
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] netsock2.c: Using SIP RTP TOS bits 184
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] netsock2.c: Using SIP RTP CoS mark 5
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] app_dial.c: Called SIP/voipms-outbound-c2/16417930727
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] app_dial.c: SIP/voipms-outbound-c2-0000dae0 answered PJSIP/1031-0000510a
[2020-02-07 12:11:52] VERBOSE[30154][C-000094bc] bridge_channel.c: Channel SIP/voipms-outbound-c2-0000dae0 joined ‘simple_bridge’ basic-bridge <01c09d10-d741-45d2-a64e-74856a1dd243>
[2020-02-07 12:11:52] VERBOSE[30152][C-000094bc] bridge_channel.c: Channel PJSIP/1031-0000510a joined ‘simple_bridge’ basic-bridge <01c09d10-d741-45d2-a64e-74856a1dd243>
[2020-02-07 12:12:02] VERBOSE[30152][C-000094bc] bridge_channel.c: Channel PJSIP/1031-0000510a left ‘simple_bridge’ basic-bridge <01c09d10-d741-45d2-a64e-74856a1dd243>
[2020-02-07 12:12:02] VERBOSE[30152][C-000094bc] app_macro.c: Spawn extension (macro-dialout-trunk, s, 24) exited non-zero on ‘PJSIP/1031-0000510a’ in macro ‘dialout-trunk’
[2020-02-07 12:12:02] VERBOSE[30154][C-000094bc] bridge_channel.c: Channel SIP/voipms-outbound-c2-0000dae0 left ‘simple_bridge’ basic-bridge <01c09d10-d741-45d2-a64e-74856a1dd243>
[2020-02-07 12:12:02] VERBOSE[30152][C-000094bc] pbx.c: Spawn extension (restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3, 16417930727, 6) exited non-zero on ‘PJSIP/1031-0000510a’
[2020-02-07 12:12:02] VERBOSE[30152][C-000094bc] pbx.c: Executing [h@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:1] Hangup(“PJSIP/1031-0000510a”, “”) in new stack
[2020-02-07 12:12:02] VERBOSE[30152][C-000094bc] pbx.c: Spawn extension (restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3, h, 1) exited non-zero on ‘PJSIP/1031-0000510a’

[2020-02-07 12:12:05] VERBOSE[6928] pbx_variables.c: Setting global variable ‘SIPDOMAIN’ to ‘pbx1.domain.com
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [16417930727@from-internal:1] Macro(“PJSIP/1031-0000510b”, “user-callerid,LIMIT”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/1031-0000510b”, “TOUCH_MONITOR=1581106325.168621”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/1031-0000510b”, “AMPUSER=1031”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“PJSIP/1031-0000510b”, “0?report”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“PJSIP/1031-0000510b”, “1?Set(REALCALLERIDNUM=1031)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/1031-0000510b”, “AMPUSER=1031”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“PJSIP/1031-0000510b”, “0?limit”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:7] Set(“PJSIP/1031-0000510b”, “AMPUSERCIDNAME=Susan Garbert”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:8] ExecIf(“PJSIP/1031-0000510b”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:9] GotoIf(“PJSIP/1031-0000510b”, “0?report”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:10] Set(“PJSIP/1031-0000510b”, “AMPUSERCID=1031”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:11] Set(“PJSIP/1031-0000510b”, “__DIAL_OPTIONS=”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:12] Set(“PJSIP/1031-0000510b”, “CALLERID(all)=“Susan Garbert” <1031>”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:13] GotoIf(“PJSIP/1031-0000510b”, “0?limit”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:14] ExecIf(“PJSIP/1031-0000510b”, “1?Set(GROUP(concurrency_limit)=1031)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:15] ExecIf(“PJSIP/1031-0000510b”, “0?Set(CHANNEL(language)=)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:16] NoOp(“PJSIP/1031-0000510b”, “Macro Depth is 1”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:17] GotoIf(“PJSIP/1031-0000510b”, “1?report2:macroerror”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx_builtins.c: Goto (macro-user-callerid,s,18)
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:18] GotoIf(“PJSIP/1031-0000510b”, “1?continue”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx_builtins.c: Goto (macro-user-callerid,s,37)
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:37] Set(“PJSIP/1031-0000510b”, “CALLERID(number)=1031”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:38] Set(“PJSIP/1031-0000510b”, “CALLERID(name)=Susan Garbert”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:39] GotoIf(“PJSIP/1031-0000510b”, “0?cnum”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:40] Set(“PJSIP/1031-0000510b”, “CDR(cnam)=Susan Garbert”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:41] Set(“PJSIP/1031-0000510b”, “CDR(cnum)=1031”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-user-callerid:42] Set(“PJSIP/1031-0000510b”, “CHANNEL(language)=en”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [16417930727@from-internal:2] Set(“PJSIP/1031-0000510b”, “ROUTEUSER=1031”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [16417930727@from-internal:3] Set(“PJSIP/1031-0000510b”, “ROUTEUSER=1031”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [16417930727@from-internal:4] GotoIf(“PJSIP/1031-0000510b”, “1?notblind”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx_builtins.c: Goto (from-internal,16417930727,7)
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [16417930727@from-internal:7] GotoIf(“PJSIP/1031-0000510b”, “1?restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3,16417930727,2:outbound-allroutes,16417930727,2”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx_builtins.c: Goto (restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3,16417930727,2)
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [16417930727@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:2] Gosub(“PJSIP/1031-0000510b”, “sub-record-check,s,1(out,16417930727,dontcare)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:1] GotoIf(“PJSIP/1031-0000510b”, “0?initialized”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:2] Set(“PJSIP/1031-0000510b”, “__REC_STATUS=INITIALIZED”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:3] Set(“PJSIP/1031-0000510b”, “NOW=1581106325”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:4] Set(“PJSIP/1031-0000510b”, “__DAY=07”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:5] Set(“PJSIP/1031-0000510b”, “__MONTH=02”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:6] Set(“PJSIP/1031-0000510b”, “__YEAR=2020”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:7] Set(“PJSIP/1031-0000510b”, “__TIMESTR=20200207-121205”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:8] Set(“PJSIP/1031-0000510b”, “__FROMEXTEN=1031”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:9] Set(“PJSIP/1031-0000510b”, “__MON_FMT=wav”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:10] NoOp(“PJSIP/1031-0000510b”, “Recordings initialized”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:11] ExecIf(“PJSIP/1031-0000510b”, “0?Set(ARG3=dontcare)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:12] Set(“PJSIP/1031-0000510b”, “REC_POLICY_MODE_SAVE=”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:13] ExecIf(“PJSIP/1031-0000510b”, “0?Set(REC_STATUS=NO)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:14] GotoIf(“PJSIP/1031-0000510b”, “3?checkaction”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx_builtins.c: Goto (sub-record-check,s,17)
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@sub-record-check:17] GotoIf(“PJSIP/1031-0000510b”, “1?sub-record-check,out,1”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx_builtins.c: Goto (sub-record-check,out,1)
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [out@sub-record-check:1] NoOp(“PJSIP/1031-0000510b”, “Outbound Recording Check from 1031 to 16417930727”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [out@sub-record-check:2] Set(“PJSIP/1031-0000510b”, “RECMODE=dontcare”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [out@sub-record-check:3] ExecIf(“PJSIP/1031-0000510b”, “1?Goto(routewins)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx_builtins.c: Goto (sub-record-check,out,7)
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [out@sub-record-check:7] Gosub(“PJSIP/1031-0000510b”, “recordcheck,1(dontcare,out,16417930727)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/1031-0000510b”, “Starting recording check against dontcare”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/1031-0000510b”, “dontcare”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“PJSIP/1031-0000510b”, “”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [out@sub-record-check:8] Return(“PJSIP/1031-0000510b”, “”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [16417930727@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:3] ExecIf(“PJSIP/1031-0000510b”, “0 ?Set(CDR(accountcode)=)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [16417930727@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:4] Set(“PJSIP/1031-0000510b”, “MOHCLASS=default”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [16417930727@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:5] Set(“PJSIP/1031-0000510b”, “_NODEST=”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [16417930727@restrictedroute-afe1a52c4f7f5da8b3b7c53b1dc75cc3:6] Macro(“PJSIP/1031-0000510b”, “dialout-trunk,3,16417930727,off”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:1] Set(“PJSIP/1031-0000510b”, “DIAL_TRUNK=3”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf(“PJSIP/1031-0000510b”, “0?Set(DIAL_OPTIONS=)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf(“PJSIP/1031-0000510b”, “0?sub-pincheck,s,1()”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:4] GotoIf(“PJSIP/1031-0000510b”, “0?disabletrunk,1”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:5] Set(“PJSIP/1031-0000510b”, “DIAL_NUMBER=16417930727”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:6] Set(“PJSIP/1031-0000510b”, “DIAL_TRUNK_OPTIONS=”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:7] Set(“PJSIP/1031-0000510b”, “OUTBOUND_GROUP=OUT_3”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:8] Set(“PJSIP/1031-0000510b”, “DIAL_TRUNK_OPTIONS=”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:9] GotoIf(“PJSIP/1031-0000510b”, “1?nomax”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx_builtins.c: Goto (macro-dialout-trunk,s,11)
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:11] GotoIf(“PJSIP/1031-0000510b”, “0?skipoutcid”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:12] Macro(“PJSIP/1031-0000510b”, “outbound-callerid,3”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:1] ExecIf(“PJSIP/1031-0000510b”, “0?Set(CALLERPRES(name-pres)=)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:2] ExecIf(“PJSIP/1031-0000510b”, “0?Set(CALLERPRES(num-pres)=)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:3] ExecIf(“PJSIP/1031-0000510b”, “0?Set(REALCALLERIDNUM=1031)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf(“PJSIP/1031-0000510b”, “0?Set(AMPUSER=1031)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:5] GotoIf(“PJSIP/1031-0000510b”, “1?normcid”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx_builtins.c: Goto (macro-outbound-callerid,s,9)
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:9] Set(“PJSIP/1031-0000510b”, “USEROUTCID=“Burlingame Construction”<5551113690>”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:10] Set(“PJSIP/1031-0000510b”, “EMERGENCYCID=”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:11] Set(“PJSIP/1031-0000510b”, “TRUNKOUTCID=”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:12] GotoIf(“PJSIP/1031-0000510b”, “1?trunkcid”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx_builtins.c: Goto (macro-outbound-callerid,s,18)
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:18] ExecIf(“PJSIP/1031-0000510b”, “0?Set(CALLERID(all)=)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:19] ExecIf(“PJSIP/1031-0000510b”, “1?Set(CALLERID(all)=“Burlingame Construction”<5551113690>)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:20] ExecIf(“PJSIP/1031-0000510b”, “0?Set(CALLERID(all)=)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:21] ExecIf(“PJSIP/1031-0000510b”, “0?Set(CALLERPRES(name-pres)=prohib_passed_screen)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf(“PJSIP/1031-0000510b”, “0?Set(CALLERPRES(num-pres)=prohib_passed_screen)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:23] Set(“PJSIP/1031-0000510b”, “CDR(outbound_cnum)=5551113690”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-outbound-callerid:24] Set(“PJSIP/1031-0000510b”, “CDR(outbound_cnam)=Burlingame Construction”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:13] GosubIf(“PJSIP/1031-0000510b”, “0?sub-flp-3,s,1()”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:14] Set(“PJSIP/1031-0000510b”, “OUTNUM=16417930727”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:15] Set(“PJSIP/1031-0000510b”, “custom=SIP/voipms-outbound-c2”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:16] ExecIf(“PJSIP/1031-0000510b”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf(“PJSIP/1031-0000510b”, “0?Set(DIAL_TRUNK_OPTIONS=M(confirm))”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:18] Macro(“PJSIP/1031-0000510b”, “dialout-trunk-predial-hook,”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“PJSIP/1031-0000510b”, “”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:19] GotoIf(“PJSIP/1031-0000510b”, “0?bypass,1”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:20] ExecIf(“PJSIP/1031-0000510b”, “1?Set(CONNECTEDLINE(num,i)=16417930727)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:21] ExecIf(“PJSIP/1031-0000510b”, “1?Set(CONNECTEDLINE(name,i)=CID:5551113690)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:22] ExecIf(“PJSIP/1031-0000510b”, “0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)5551113690)”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:23] GotoIf(“PJSIP/1031-0000510b”, “0?customtrunk”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] pbx.c: Executing [s@macro-dialout-trunk:24] Dial(“PJSIP/1031-0000510b”, “SIP/voipms-outbound-c2/16417930727,300,”) in new stack
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] netsock2.c: Using SIP RTP TOS bits 184
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] netsock2.c: Using SIP RTP CoS mark 5
[2020-02-07 12:12:05] VERBOSE[30215][C-000094bd] app_dial.c: Called SIP/voipms-outbound-c2/16417930727

LOG END =======

I’m very puzzled by your log. Although it shows three calls made by the hacker, there are no inbound calls at all and nothing that shows an IVR being accessed. Yet the CDR log in an earlier post shows an attended transfer and you have stated that disabling extension access from the IVR stops the attack.

Did you filter this log in some way, or is it possible that a single inbound call made before [2020-02-07 12:11:29] (the start of your posted log) was in progress at the time of the hack?

Please confirm that when you are on your mobile phone and have called in, selected extension 1031 and waited for answer (e.g. by voicemail), nothing happens when you press *2 or ## .

If you can locate an incoming call in the log that selected extension 1031, please post the relevant log section. Please don’t post lengthy logs directly in the forum. Paste them at pastebin.freepbx.org and post the link here.

On Ext 1031 while connected to my cell phone, *2 and ## and will not get you a dial tone. . Also tried if on the Cell phone and same result.

I also don’t see incoming on the CDR also but I’m no expert on analyzing CDR’s
It might be a coincident that it stop when I disable direct dial

Ext 1031 is a Sangoma s500 Zero Touch configured with endpoint manager
Assuming the hacker got the password for ext 1031
And register another ext 1031, I should see his IP address right?
The IP address I’m seeing for 1031 is correct.

How about if I change the the password and then use endpoint manager to reboot the phone
I don’t have physical access to the phone. WIll it reboot and get the new config?

Every time I to pastebin and click on capTCHA, it removes what I paste
Hope this link works
https://drive.google.com/open?id=18FCEIcFpeMIAxf9Htea-mwbUYvDUDWnG

This file is complere but I change the IP address just incase someone else is reading it.

Thanks

There is a bug in FreePBX (recently fixed for I think 14 & 15 only) which allowed callers to dial any extension in an IVR even it was tied to a directory.

https://issues.freepbx.org/browse/FREEPBX-20876

[2020-02-07 12:11:00] VERBOSE[26896] res_pjsip_registrar.c: Added contact 'sip:[email protected]:41822' to AOR '1031' with expiration of 3600 seconds
[2020-02-07 12:11:00] VERBOSE[26896] res_pjsip_registrar.c: Removed contact 'sip:[email protected]:51480' from AOR '1031' due to remove_existing
[2020-02-07 12:11:00] VERBOSE[6928] res_pjsip/pjsip_options.c: Contact 1031/sip:[email protected]:51480 has been deleted
[2020-02-07 12:11:00] VERBOSE[6928] res_pjsip/pjsip_configuration.c: Endpoint 1031 is now Unreachable
[2020-02-07 12:11:12] VERBOSE[32561] pbx_variables.c: Setting global variable 'SIPDOMAIN' to 'pbx4.domain.com'
[2020-02-07 12:11:12] VERBOSE[30105][C-000094ba] pbx.c: Executing [16054754301@from-internal:1] Macro("PJSIP/1031-00005108", "user-callerid,LIMIT") in new stack

OK, so a new source registered as extension 1031 and a malicious call was initiated only 12 seconds later. The old source may have also been malicious.

According to http://whois.domaintools.com/66.244.1.1 it was registered from Redding, CA. You’re in Sacramento area, does that sound legit?

According to http://whois.domaintools.com/173.9.62.169 the new source is in Nashua, NH. Is that legit?

Of course, either of these sources may have been compromised and the hacker could be anywhere in the world.

If you have set a new strong secret for the extension and it is now registered (from the legitimate IP), then you can be reasonably certain that the device rebooted and retrieved the new config properly.

With luck, the unauthorized calls have stopped.

1 Like

Sorry, I don’t know the details of how this is set up, but make sure that the attacker cannot obtain the new secret by reading the provisioning file.

Ideally, provisioning data should be accessible only from authorized IP addresses, encrypted with a key shared only by the phone and EPM, or delivered only to requests accompanied by an authorized client certificate. You can check the apache logs for access to provisioning files from unknown places.

Stewart thanks for the info. I change the password and several extension including ext 1031. Re-enable IVR direct dialing and so far no sign of the hacker. It might be just a coincident yesterday where it stop when I disable IVR direct dialing…

I also checked with the sip trunk provider and confirm the same thing. No incoming call before the attack.

sip:[email protected]:51480 is valid
sip:[email protected]:41822 is probably the hacker IP address but could be using a proxy

On the log I shared with you, I change all IP address know to me to x.x.1.1.
What ever if left is unknown to me

Thanks for your help

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