"All circuits are busy "while making an outbound PSTN call via Bria solo

FreePBX Hardware
1

Hi express,

I am a newbie and setup a test FreePBX system. 2 days ago, the sip calls between the softphones(Bria solo) were successful. I am now trying to make the PSTN working.

I just got a digium TDM400P with 3fxo and 1fxs and installed. It was shown in DAHDI Configuration/Analog hardware. The 3 fxo ports light green and one with 1 port connected to the PSTN line. I just added one rule in the Outbound routes. I tried to call a pstn number but the the Bria responded with " all circuits are busy".

I disconnected pstn line and dialed again, getting the same announcement. It seems the symptom is irrelevant to the PSTN line. I am sure the pstn line is working.

I think there might be some configurations not done properly. I got lost as I don’t which configurations need to be configured to let card work. Please could guide the major steps?

here are some cli I run:
Asterisk CLI>>>>dahdi show channels

Chan Extension Context Language MOH Interpret Blocked In Service Description
pseudo default default Yes
2 from-analog cn default Yes
3 from-analog cn default Yes
4 from-analog cn default Yes

Asterisk CLI>>>>dahdi show channel 4. (the pstn line is connected at slot 4 of the TDM400)

Channel: 4 Description: File Descriptor: 36 Span: 1 Extension: Dialing: no Context: from-analog Caller ID: Calling TON: 0 Caller ID subaddress: Caller ID name: Mailbox: none Destroy: 0 InAlarm: 1 Signalling Type: FXS Kewlstart Radio: 0 Owner: <None> Real: <None> Callwait: <None> Threeway: <None> Confno: -1 Propagated Conference: -1 Real in conference: 0 DSP: no Busy Detection: yes Busy Count: 10 Busy Pattern: 0,0,0,0 TDD: no Relax DTMF: no Dialing/CallwaitCAS: 0/0 Default law: ulaw Fax Handled: no Pulse phone: no HW Gains (RX/TX): Disabled/Disabled SW Gains (RX/TX): 0.00/0.00 Dynamic Range Compression (RX/TX): 0.00/0.00 DND: no Echo Cancellation: 128 taps (unless TDM bridged) currently OFF Wait for dialtone: 0ms Actual Confinfo: Num/0, Mode/0x0000 Actual Confmute: No Hookstate (FXS only): Onhook

linux>>> sudo dahdi_cfg -vvv

DAHDI Tools Version - 2.11.1

DAHDI Version: 2.11.1

Echo Canceller(s):

Configuration

======================

Channel map:

Channel 02: FXS Kewlstart (Default) (Echo Canceler: oslec) (Slaves: 02)

Channel 03: FXS Kewlstart (Default) (Echo Canceler: oslec) (Slaves: 03)

Channel 04: FXS Kewlstart (Default) (Echo Canceler: oslec) (Slaves: 04)

3 channels to configure.

Setting echocan for channel 2 to oslec

Setting echocan for channel 3 to oslec

Setting echocan for channel 4 to oslec

Btw, how could I check whether the card is working. I did check the Asterisk info. didn’t find card status.

Thanks!

Corydon

2

Provide a call trace via pastebin:
https://wiki.freepbx.org/display/SUP/Providing+Great+Debug#ProvidingGreatDebug-AsteriskLogs-PartII

3

Hi Lome,

Thanks for guiding me through! What kind of trace log file I should provide, Asterisk log?

corydon

4

Yes. Follow the steps in the link above for isolating a call trace from the full log.

5

Hi Lome,

By now, I have add a trunk with caller ID: 700 and Dahdi trunk: Analogy Channel 4 with Dialed Number Manipulation rules having just one fixed8 digits pstn number eg, 24671290. then I called 24671290 from extension 700. The Bria returned a message showing " Failed to establish call -busy" . Not the previous audio announcement" all circuits are busy". If I called other numbers, " you call can not be completed as Dailed, place check the number and dial again" audio announcement was played.I tried to find the calls I made from extension 700 in CDR, but couldn’t find any record matching this caller ID. Why?

Btw
There are many faked calls made with the caller ID like 175, 174 . They are all not the extensions I created. how could I block these attempts?

Call Date Recording System CallerID Outbound CallerID DID App Destination Disposition Duration Userfield Account CDR Table CDR Graph
Fri, 15 May 2020 18:24 1589538256.61 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:24 1589538240.60 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:23 1589538224.59 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:23 1589538208.58 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:23 1589538192.57 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:22 1589538177.56 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:22 1589538162.55 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:22 1589538128.53 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:21 1589538113.52 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:21 1589538097.51 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:21 1589538082.50 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:21 1589538067.49 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:21 1589538065.48 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:20 1589538050.47 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:20 1589538041.46 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:20 1589538034.45 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:20 1589538033.44 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:20 1589538025.43 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:20 1589538019.42 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:20 1589538016.41 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:20 1589538008.40 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:20 1589538003.39 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:19 1589537999.38 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:19 1589537991.36 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:19 1589537987.35 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:19 1589537982.34 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:19 1589537973.33 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:19 1589537971.32 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:19 1589537965.31 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:19 1589537955.30 175 Congestion s [from-sip-external] ANSWERED 00:12
Call Date Recording System CallerID Outbound CallerID DID App Destination Disposition Duration Userfield Account CDR Table CDR Graph
Fri, 15 May 2020 18:19 1589537947.29 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:18 1589537938.28 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:18 1589537924.27 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:18 1589537920.26 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:18 1589537908.25 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:18 1589537903.24 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:18 1589537894.23 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:18 1589537886.22 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:17 1589537877.21 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:17 1589537875.20 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:17 1589537868.19 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:17 1589537860.18 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:17 1589537859.17 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:17 1589537851.16 175 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:16 1589537807.15 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:16 1589537792.14 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:16 1589537775.13 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:15 1589537759.12 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:15 1589537743.11 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:15 1589537726.10 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:15 1589537710.9 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:14 1589537679.8 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:14 1589537663.6 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:14 1589537647.5 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:13 1589537631.4 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:13 1589537615.3 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:13 1589537609.2 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:13 1589537600.1 174 Congestion s [from-sip-external] ANSWERED 00:12
Fri, 15 May 2020 18:13 1589537600.0 174 Congestion s [from-sip-external] ANSWERED 00:12

corydon

6

Hi Lome,

Here is what I found in the Asterisk logs
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [24671290@from-internal:1] Macro(“PJSIP/700-0000010f”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/700-0000010f”, “TOUCH_MONITOR=1589540250.271”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/700-0000010f”, “AMPUSER=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“PJSIP/700-0000010f”, “0?report”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“PJSIP/700-0000010f”, “1?Set(REALCALLERIDNUM=200)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/700-0000010f”, “AMPUSER=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“PJSIP/700-0000010f”, “0?limit”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:7] Set(“PJSIP/700-0000010f”, “AMPUSERCIDNAME=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:8] ExecIf(“PJSIP/700-0000010f”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:9] GotoIf(“PJSIP/700-0000010f”, “0?report”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:10] Set(“PJSIP/700-0000010f”, “AMPUSERCID=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:11] Set(“PJSIP/700-0000010f”, “__DIAL_OPTIONS=HhTtr”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:12] Set(“PJSIP/700-0000010f”, “CALLERID(all)=“200” <200>”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:13] ExecIf(“PJSIP/700-0000010f”, “0?Set(CALLERID(all)=EXTERNAL)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:14] GotoIf(“PJSIP/700-0000010f”, “0?limit”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:15] ExecIf(“PJSIP/700-0000010f”, “1?Set(GROUP(concurrency_limit)=200)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:16] ExecIf(“PJSIP/700-0000010f”, “0?Set(CHANNEL(language)=)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:17] NoOp(“PJSIP/700-0000010f”, “Macro Depth is 1”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:18] GotoIf(“PJSIP/700-0000010f”, “1?report2:macroerror”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (macro-user-callerid,s,19)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:19] GotoIf(“PJSIP/700-0000010f”, “1?continue”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (macro-user-callerid,s,38)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:38] Set(“PJSIP/700-0000010f”, “CALLERID(number)=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:39] Set(“PJSIP/700-0000010f”, “CALLERID(name)=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:40] GotoIf(“PJSIP/700-0000010f”, “0?cnum”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:41] Set(“PJSIP/700-0000010f”, “CDR(cnam)=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:42] Set(“PJSIP/700-0000010f”, “CDR(cnum)=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-user-callerid:43] Set(“PJSIP/700-0000010f”, “CHANNEL(language)=en”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [24671290@from-internal:2] Gosub(“PJSIP/700-0000010f”, “sub-record-check,s,1(out,24671290,dontcare)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:1] GotoIf(“PJSIP/700-0000010f”, “0?initialized”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:2] Set(“PJSIP/700-0000010f”, “__REC_STATUS=INITIALIZED”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:3] Set(“PJSIP/700-0000010f”, “NOW=1589540250”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:4] Set(“PJSIP/700-0000010f”, “__DAY=15”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:5] Set(“PJSIP/700-0000010f”, “__MONTH=05”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:6] Set(“PJSIP/700-0000010f”, “__YEAR=2020”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:7] Set(“PJSIP/700-0000010f”, “__TIMESTR=20200515-105730”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:8] Set(“PJSIP/700-0000010f”, “__FROMEXTEN=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:9] Set(“PJSIP/700-0000010f”, “__MON_FMT=wav”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:10] NoOp(“PJSIP/700-0000010f”, “Recordings initialized”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:11] ExecIf(“PJSIP/700-0000010f”, “0?Set(ARG3=dontcare)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:12] Set(“PJSIP/700-0000010f”, “REC_POLICY_MODE_SAVE=”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:13] ExecIf(“PJSIP/700-0000010f”, “0?Set(REC_STATUS=NO)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:14] GotoIf(“PJSIP/700-0000010f”, “3?checkaction”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (sub-record-check,s,17)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-record-check:17] GotoIf(“PJSIP/700-0000010f”, “1?sub-record-check,out,1”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (sub-record-check,out,1)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [out@sub-record-check:1] NoOp(“PJSIP/700-0000010f”, “Outbound Recording Check from 200 to 24671290”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [out@sub-record-check:2] Set(“PJSIP/700-0000010f”, “RECMODE=dontcare”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [out@sub-record-check:3] ExecIf(“PJSIP/700-0000010f”, “1?Goto(routewins)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (sub-record-check,out,7)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [out@sub-record-check:7] Gosub(“PJSIP/700-0000010f”, “recordcheck,1(dontcare,out,24671290)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/700-0000010f”, “Starting recording check against dontcare”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/700-0000010f”, “dontcare”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“PJSIP/700-0000010f”, “”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [out@sub-record-check:8] Return(“PJSIP/700-0000010f”, “”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [24671290@from-internal:3] ExecIf(“PJSIP/700-0000010f”, “0 ?Set(CDR(accountcode)=)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [24671290@from-internal:4] Set(“PJSIP/700-0000010f”, “MOHCLASS=default”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [24671290@from-internal:5] Set(“PJSIP/700-0000010f”, “_NODEST=”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [24671290@from-internal:6] Macro(“PJSIP/700-0000010f”, “dialout-trunk,1,24671290,off”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:1] Set(“PJSIP/700-0000010f”, “DIAL_TRUNK=1”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf(“PJSIP/700-0000010f”, “0?Set(DIAL_OPTIONS=Hhtr)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf(“PJSIP/700-0000010f”, “0?sub-pincheck,s,1()”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:4] ExecIf(“PJSIP/700-0000010f”, “0?Set(CALLERID(num)=200)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:5] GotoIf(“PJSIP/700-0000010f”, “0?disabletrunk,1”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:6] Set(“PJSIP/700-0000010f”, “DIAL_NUMBER=24671290”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:7] Set(“PJSIP/700-0000010f”, “DIAL_TRUNK_OPTIONS=HhTtr”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:8] Set(“PJSIP/700-0000010f”, “OUTBOUND_GROUP=OUT_1”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:9] Set(“PJSIP/700-0000010f”, “DIAL_TRUNK_OPTIONS=T”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:10] GotoIf(“PJSIP/700-0000010f”, “0?nomax”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:11] GotoIf(“PJSIP/700-0000010f”, “0?chanfull”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf(“PJSIP/700-0000010f”, “0?skipoutcid”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:13] Macro(“PJSIP/700-0000010f”, “outbound-callerid,1”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:1] NoOp(“PJSIP/700-0000010f”, “200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:2] NoOp(“PJSIP/700-0000010f”, “”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:3] NoOp(“PJSIP/700-0000010f”, “on”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf(“PJSIP/700-0000010f”, “0?Set(CALLERPRES(name-pres)=)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:5] ExecIf(“PJSIP/700-0000010f”, “0?Set(CALLERPRES(num-pres)=)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:6] ExecIf(“PJSIP/700-0000010f”, “0?Set(REALCALLERIDNUM=200)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:7] ExecIf(“PJSIP/700-0000010f”, “0?Set(AMPUSER=200)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:8] GotoIf(“PJSIP/700-0000010f”, “1?normcid”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (macro-outbound-callerid,s,12)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:12] Set(“PJSIP/700-0000010f”, “USEROUTCID=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:13] Set(“PJSIP/700-0000010f”, “EMERGENCYCID=”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:14] Set(“PJSIP/700-0000010f”, “TRUNKOUTCID=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:15] GotoIf(“PJSIP/700-0000010f”, “1?trunkcid”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (macro-outbound-callerid,s,21)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:21] ExecIf(“PJSIP/700-0000010f”, “1?Set(CALLERID(all)=200)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf(“PJSIP/700-0000010f”, “1?Set(CALLERID(all)=200)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:23] ExecIf(“PJSIP/700-0000010f”, “0?Set(CALLERID(all)=)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:24] ExecIf(“PJSIP/700-0000010f”, “0?Set(CALLERID(all)=200)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:25] Set(“PJSIP/700-0000010f”, “TIOHIDE=no”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:26] ExecIf(“PJSIP/700-0000010f”, “0?Set(CALLERPRES(name-pres)=prohib_passed_screen)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:27] ExecIf(“PJSIP/700-0000010f”, “0?Set(CALLERPRES(num-pres)=prohib_passed_screen)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:28] ExecIf(“PJSIP/700-0000010f”, “0?Set(CALLERPRES(name-pres)=prohib_passed_screen)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:29] ExecIf(“PJSIP/700-0000010f”, “0?Set(CALLERPRES(num-pres)=prohib_passed_screen)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:30] Set(“PJSIP/700-0000010f”, “CDR(outbound_cnum)=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-outbound-callerid:31] Set(“PJSIP/700-0000010f”, “CDR(outbound_cnam)=”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf(“PJSIP/700-0000010f”, “1?sub-flp-1,s,1()”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@sub-flp-1:1] ExecIf(“PJSIP/700-0000010f”, “1?Return()”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:15] Set(“PJSIP/700-0000010f”, “OUTNUM=24671290”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:16] Set(“PJSIP/700-0000010f”, “custom=DAHDI/4”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf(“PJSIP/700-0000010f”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf(“PJSIP/700-0000010f”, “0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:19] Macro(“PJSIP/700-0000010f”, “dialout-trunk-predial-hook,”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“PJSIP/700-0000010f”, “”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:20] GotoIf(“PJSIP/700-0000010f”, “0?skipcrm”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:21] Set(“PJSIP/700-0000010f”, “__CRM_DIRECTION=OUTBOUND”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:22] Set(“PJSIP/700-0000010f”, “__CRM_DESTINATION=24671290”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:23] Set(“PJSIP/700-0000010f”, “__CRM_SOURCE=200”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:24] AGI(“PJSIP/700-0000010f”, “agi://127.0.0.1/sangomacrm.agi”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] res_agi.c: <PJSIP/700-0000010f>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:25] Set(“PJSIP/700-0000010f”, “CHANNEL(hangup_handler_push)=crm-hangup,s,1”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:26] NoOp(“PJSIP/700-0000010f”, “CRM Finished”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:27] GotoIf(“PJSIP/700-0000010f”, “0?bypass,1”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:28] ExecIf(“PJSIP/700-0000010f”, “1?Set(CONNECTEDLINE(num,i)=24671290)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:29] ExecIf(“PJSIP/700-0000010f”, “1?Set(CONNECTEDLINE(name,i)=CID:200)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:30] ExecIf(“PJSIP/700-0000010f”, “0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)200)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:31] GotoIf(“PJSIP/700-0000010f”, “0?customtrunk”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:32] ExecIf(“PJSIP/700-0000010f”, “0?Set(DIAL_TRUNK_OPTIONS=)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:33] Dial(“PJSIP/700-0000010f”, “DAHDI/4/24671290,300,Tb(func-apply-sipheaders^s^1,(1))”) in new stack
[2020-05-15 10:57:30] WARNING[21147][C-00000110] app_dial.c: Unable to create channel of type ‘DAHDI’ (cause 17 - User busy)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] app_dial.c: No devices or endpoints to dial (technology/resource)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:34] NoOp(“PJSIP/700-0000010f”, “Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 17”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-dialout-trunk:35] GotoIf(“PJSIP/700-0000010f”, “0?continue,1:s-CHANUNAVAIL,1”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set(“PJSIP/700-0000010f”, “RC=17”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto(“PJSIP/700-0000010f”, “17,1”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (macro-dialout-trunk,17,1)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [17@macro-dialout-trunk:1] Goto(“PJSIP/700-0000010f”, “s-BUSY,1”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (macro-dialout-trunk,s-BUSY,1)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s-BUSY@macro-dialout-trunk:1] NoOp(“PJSIP/700-0000010f”, “Dial failed due to trunk reporting BUSY - giving up”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s-BUSY@macro-dialout-trunk:2] PlayTones(“PJSIP/700-0000010f”, “busy”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s-BUSY@macro-dialout-trunk:3] Busy(“PJSIP/700-0000010f”, “20”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] app_macro.c: Spawn extension (macro-dialout-trunk, s-BUSY, 3) exited non-zero on ‘PJSIP/700-0000010f’ in macro ‘dialout-trunk’
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Spawn extension (from-internal, 24671290, 6) exited non-zero on ‘PJSIP/700-0000010f’
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [h@from-internal:1] Macro(“PJSIP/700-0000010f”, “hangupcall”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-hangupcall:1] GotoIf(“PJSIP/700-0000010f”, “1?theend”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-hangupcall:3] ExecIf(“PJSIP/700-0000010f”, “0?Set(CDR(recordingfile)=)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-hangupcall:4] NoOp(“PJSIP/700-0000010f”, " montior file= ") in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-hangupcall:5] GotoIf(“PJSIP/700-0000010f”, “1?skipagi”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx_builtins.c: Goto (macro-hangupcall,s,7)
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@macro-hangupcall:7] Hangup(“PJSIP/700-0000010f”, “”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on ‘PJSIP/700-0000010f’ in macro ‘hangupcall’
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on ‘PJSIP/700-0000010f’
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] app_stack.c: PJSIP/700-0000010f Internal Gosub(crm-hangup,s,1) start
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@crm-hangup:1] NoOp(“PJSIP/700-0000010f”, “Sending Hangup to CRM”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@crm-hangup:2] NoOp(“PJSIP/700-0000010f”, “HANGUP CAUSE: 17”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@crm-hangup:3] ExecIf(“PJSIP/700-0000010f”, “0?Set(__CRM_VOICEMAIL=)”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@crm-hangup:4] NoOp(“PJSIP/700-0000010f”, “MASTER CHANNEL: 1589540250.271 = 1589540250.271”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@crm-hangup:5] GotoIf(“PJSIP/700-0000010f”, “0?return”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@crm-hangup:6] Set(“PJSIP/700-0000010f”, “__CRM_HANGUP=1”) in new stack
[2020-05-15 10:57:30] VERBOSE[21147][C-00000110] pbx.c: Executing [s@crm-hangup:7] AGI(“PJSIP/700-0000010f”, “agi://127.0.0.1/sangomacrm.agi”) in new stack

7

Hi Lome,

I did some research and found
in “extensions.conf”

[globals]
TRUNK=DAHDI/4-1

are missing.

in “chan_dahdi.conf”

[channels]
signalling = fxs_ks ; in Asterisk, FXO channels use FXS signaling
channel => 1-4 ; apply all the previously defined settings to this channel

are missing.

Not sure if relevant.

Thanks!

Corydon

8

Hi Lome,

I solved it. I pluged the pstn line in FXS port. Shame…

Btw, I found my server is being scanned by unkonwn ip. Actually I have already reinstalled the system , enabled the responsive firewall, used a new domain name. but I am still using 5060. for sip. Any action I should take to block the attacks?

Thanks!

9

The ‘standard’ way to do this is to NOT turn on the Adaptive Firewall (it’s only for people you have extensions on your system that call from weird places). Turn that off and set up the interface (using the Integrated Firewall) so that only the addresses you are expecting to send you call (your ITSP) can access port 5060.

Also, make sure that Guest and Anonymous connections are disabled in the Advanced Settings.

It doesn’t stop the “pre firewall” attempts to connect, but it does stop them from getting connected to the system.

10

@cynjut,

I didn’t find the Adaptive Firewall and “Guest and Anonymous” option in Advanced Setting.
As I have some remote soft phones , howl could I just let them access system?

From sngrep I can find
Many registrations and call setups as below, the domain 192.160.0.37 is the FreePBX host ip
Call flow for 3873794042 (Color by Request/Response)
│REGISTER sip:192.168.0.37:5060 SIP/2.0
45.143.220.18:5088 192.168.0.37:5060 │Via: SIP/2.0/UDP 45.143.220.18:5088;branch=z9hG4bK-2295006170;rport
──────────┬───────── ──────────┬─────────│Content-Length: 0
│ REGISTER │ │From: “120” sip:[email protected]:5060;tag=1948450595
22:26:46.469248 │ ──────────────────────────> │ │Accept: application/sdp
+0.000513 │ 401 Unauthorized │ │User-Agent: FPBX
22:26:46.469761 │ <────────────────────────── │ │To: “120” sip:[email protected]:5060
+0.222727 │ REGISTER │ │Contact: sip:[email protected]
22:26:46.692488 │ ──────────────────────────> │ │CSeq: 1 REGISTER
+0.000653 │ 401 Unauthorized │ │Call-ID: 3873794042
22:26:46.693141 │ <────────────────────────── │ │Max-Forwards: 70

198.144.177.187:51661 192.168.0.37:5060 │Via: SIP/2.0/UDP 198.144.177.187:51661;branch=z9hG4bK139167681
──────────┬───────── ──────────┬─────────│Max-Forwards: 70
│ INVITE (SDP) │ │From: sip:[email protected]:5060;tag=932956612
22:26:42.623826 │ ──────────────────────────> │ │To: sip:[email protected]:5060
│ │ │Call-ID: 1460851698-414388357-945159445
│ │ │CSeq: 1 INVITE
│ │ │Contact: sip:[email protected]:51661
│ │ │Content-Type: application/sdp
│ │ │Content-Length: 208
│ │ │Allow: ACK, BYE, CANCEL, INFO, INVITE, MESSAGE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER, SUBSCRIBE, UPDATE, PUBLISH
│ │ │
│ │ │v=0
│ │ │o=2001 16264 18299 IN IP4 192.168.1.83
│ │ │s=call
│ │ │c=IN IP4 192.168.1.83
│ │ │t=0 0
│ │ │m=audio 25282 RTP/AVP 0 101
│ │ │a=rtpmap:0 pcmu/8000
│ │ │a=rtpmap:8 pcma/8000
│ │ │a=rtpmap:101 telephone-event/8000
│ │ │a=fmtp:101 0-11

How could I prevent these kinds of attacks happening?

Thanks!

Corydon

11

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