User busy issue for incoming call in A400P 4 FXO card

Hi,

I setup Tribox 2.8.x with A400P 4 x FXO board (Purchased couple of week back). There are one analog line plugged into port 1.

The system is located in Canada. Country setting in configuration is US.

Internal extension (200) can make calls to PSTN without any issue.

When I make inbound call, caller get busy tone "user busy' message right away.

Caller phone (mobile phone) get busy before we see "Starting simple switch on 'DAHDI/1-1'" in asterisk console.

Asterisk log shows following log and internal extension (200) rings for that call and hangup (log below).

I would like to get your feedback to resolve the issue and will appreciate it.

Thanks
Selva


[PBX1.localdomain dahdi]# lsdahdi
### Span 1: WCTDM/4 "Wildcard TDM400P REV E/F Board 5" (MASTER)
1 FXO FXSKS (In use) (SWEC: MG2)
2 FXO FXSKS (In use) (SWEC: MG2) RED
3 FXO FXSKS (In use) (SWEC: MG2) RED
4 FXO FXSKS (In use) (SWEC: MG2) RED


PBX1*CLI> dahdi show regdump 1
Direct registers:
0. 00 1. 00 2. 03 3. 00 4. e9 5. 08 6. 00 7. 00
8. 00 9. 00 10. 00 11. 35 12. 40 13. 58 14. 00 15. 00
16. 01 17. 02 18. 00 19. 02 20. 00 21. 00 22. 96 23. 2d
24. 19 25. 08 26. c0 27. 05 28. 00 29. 34 30. 00 31. a3
32. 07 33. 28 34. 18 35. 00 36. 18 37. 00 38. 10 39. 10
40. 10 41. 10 42. 00 43. 00 44. 00 45. 00 46. 00 47. 00
48. 00 49. 00 50. 00 51. 00 52. 00 53. 00 54. 00 55. 00
56. 0f 57. 00 58. 00 59. 00

TIP: 52.0000 Volts
RING: 52.0000 Volts
VBAT: 52.0000 Volts

PBX1*CLI> dahdi show regdump 2
Direct registers:
0. 00 1. 00 2. 03 3. 00 4. 29 5. 08 6. 00 7. 00
8. 00 9. 00 10. 00 11. 35 12. 40 13. 58 14. 00 15. 00
16. 01 17. 00 18. 00 19. 02 20. 00 21. 00 22. 96 23. 2d
24. 19 25. 08 26. c0 27. 07 28. 00 29. 01 30. 00 31. a3
32. 07 33. 28 34. 10 35. 00 36. 10 37. 00 38. 10 39. 10
40. 10 41. 10 42. 00 43. 00 44. 00 45. 00 46. 00 47. 00
48. 00 49. 00 50. 00 51. 00 52. 00 53. 00 54. 00 55. 00
56. 0f 57. 00 58. 00 59. 00

TIP: 1.0000 Volts
RING: 1.0000 Volts
VBAT: 1.0000 Volts

---

-- Starting simple switch on 'DAHDI/1-1'
-- Executing [s@from-pstn:1] Set("DAHDI/1-1", "__FROM_DID=s") in new stack
-- Executing [s@from-pstn:2] Gosub("DAHDI/1-1", "app-blacklist-check,s,1") i n new stack
-- Executing [s@app-blacklist-check:1] GotoIf("DAHDI/1-1", "0?blacklisted") in new stack
-- Executing [s@app-blacklist-check:2] Return("DAHDI/1-1", "") in new stack
-- Executing [s@from-pstn:3] ExecIf("DAHDI/1-1", "1 ?Set(CALLERID(name)=)") in new stack
-- Executing [s@from-pstn:4] Set("DAHDI/1-1", "__CALLINGPRES_SV=allowed_not_ screened") in new stack
-- Executing [s@from-pstn:5] Set("DAHDI/1-1", "CALLERPRES()=allowed_not_scre ened") in new stack
-- Executing [s@from-pstn:6] Goto("DAHDI/1-1", "from-did-direct,200,1") in n ew stack
-- Goto (from-did-direct,200,1)
-- Executing [200@from-did-direct:1] Macro("DAHDI/1-1", "exten-vm,200,200") in new stack
-- Executing [s@macro-exten-vm:1] Macro("DAHDI/1-1", "user-callerid") in new stack
-- Executing [s@macro-user-callerid:1] Set("DAHDI/1-1", "AMPUSER=") in new s tack
-- Executing [s@macro-user-callerid:2] GotoIf("DAHDI/1-1", "0?report") in ne w stack
-- Executing [s@macro-user-callerid:3] ExecIf("DAHDI/1-1", "1?Set(REALCALLER IDNUM=)") in new stack
-- Executing [s@macro-user-callerid:4] Set("DAHDI/1-1", "AMPUSER=") in new s tack
-- Executing [s@macro-user-callerid:5] Set("DAHDI/1-1", "AMPUSERCIDNAME=") i n new stack
-- Executing [s@macro-user-callerid:6] GotoIf("DAHDI/1-1", "1?report") in ne w stack
-- Goto (macro-user-callerid,s,10)
-- Executing [s@macro-user-callerid:10] GotoIf("DAHDI/1-1", "0?continue") in new stack
-- Executing [s@macro-user-callerid:11] Set("DAHDI/1-1", "__TTL=64") in new stack
-- Executing [s@macro-user-callerid:12] GotoIf("DAHDI/1-1", "1?continue") in new stack
-- Goto (macro-user-callerid,s,19)
-- Executing [s@macro-user-callerid:19] NoOp("DAHDI/1-1", "Using CallerID "" <>") in new stack
-- Executing [s@macro-exten-vm:2] Set("DAHDI/1-1", "RingGroupMethod=none") i n new stack
-- Executing [s@macro-exten-vm:3] Set("DAHDI/1-1", "VMBOX=200") in new stack
-- Executing [s@macro-exten-vm:4] Set("DAHDI/1-1", "EXTTOCALL=200") in new s tack
-- Executing [s@macro-exten-vm:5] Set("DAHDI/1-1", "CFUEXT=") in new stack
-- Executing [s@macro-exten-vm:6] Set("DAHDI/1-1", "CFBEXT=") in new stack
-- Executing [s@macro-exten-vm:7] Set("DAHDI/1-1", "RT=15") in new stack
-- Executing [s@macro-exten-vm:8] Macro("DAHDI/1-1", "record-enable,200,IN") in new stack
-- Executing [s@macro-record-enable:1] GotoIf("DAHDI/1-1", "1?check") in new stack
-- Goto (macro-record-enable,s,4)
-- Executing [s@macro-record-enable:4] AGI("DAHDI/1-1", "recordingcheck,2013 0103-002934,1357190966.4") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
recordingcheck,20130103-002934,1357190966.4: Inbound recording not enabled
-- <DAHDI/1-1>AGI Script recordingcheck completed, returning 0
-- Executing [s@macro-record-enable:5] MacroExit("DAHDI/1-1", "") in new sta ck
-- Executing [s@macro-exten-vm:9] Macro("DAHDI/1-1", "dial,15,tr,200") in ne w stack
-- Executing [s@macro-dial:1] GotoIf("DAHDI/1-1", "1?dial") in new stack
-- Goto (macro-dial,s,3)
-- Executing [s@macro-dial:3] AGI("DAHDI/1-1", "dialparties.agi") in new sta ck
-- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
dialparties.agi: Starting New Dialparties.agi
dialparties.agi: Caller ID name is 'unknown' number is 'unknown'
> dialparties.agi: USE_CONFIRMATION: 'FALSE'
> dialparties.agi: RINGGROUP_INDEX: ''
dialparties.agi: Methodology of ring is 'none'
-- dialparties.agi: Added extension 200 to extension map
> dialparties.agi: Extension 200 has call screening off
-- dialparties.agi: Extension 200 cf is disabled
-- dialparties.agi: Extension 200 do not disturb is disabled
> dialparties.agi: extnum 200 has: cw: 1; hascfb: 0 [] hascfu: 0 []
dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
-- dialparties.agi: DbDel CALLTRACE/200 - Caller ID is not defined
-- dialparties.agi: Filtered ARG3: 200
-- <DAHDI/1-1>AGI Script dialparties.agi completed, returning 0
-- Executing [s@macro-dial:7] Dial("DAHDI/1-1", "SIP/200,15,tr") in new stac k
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
== Using SIP VRTP TOS bits 136
== Using SIP VRTP CoS mark 6
-- Called 200
<< [ TYPE: Control (4) SUBCLASS: Ringing (3) ] [SIP/200-00000002]
-- SIP/200-00000002 is ringing
<< [ TYPE: Control (4) SUBCLASS: Ringing (3) ] [SIP/200-00000002]
-- SIP/200-00000002 is ringing
<< [ HANGUP (NULL) ] [DAHDI/1-1]
== Spawn extension (macro-dial, s, 7) exited non-zero on 'DAHDI/1-1' in macro 'dial'
== Spawn extension (macro-exten-vm, s, 9) exited non-zero on 'DAHDI/1-1' in ma cro 'exten-vm'
== Spawn extension (from-did-direct, 200, 1) exited non-zero on 'DAHDI/1-1'
-- Hungup 'DAHDI/1-1'

Demsg shows following detail:

---

NET: Registered protocol family 10
lo: Disabled Privacy Extensions
IPv6 over IPv4 tunneling driver
dahdi: Telephony Interface Registered on major 196
dahdi: Version: 2.3.0.1
ACPI: PCI Interrupt 0000:01:06.0[A] -> GSI 18 (level, low) -> IRQ 169
Freshmaker version: 71
Freshmaker passed register test
Module 0: Installed -- AUTO FXO (FCC mode)
Module 1: Installed -- AUTO FXO (FCC mode)
Module 2: Installed -- AUTO FXO (FCC mode)
Module 3: Installed -- AUTO FXO (FCC mode)
Found a Wildcard TDM: Wildcard TDM400P REV E/F (4 modules)
dahdi_transcode: Loaded.
INFO-xpp: revision Unknown MAX_XPDS=64 (8*
INFO-xpp: FEATURE: without BRISTUFF support
INFO-xpp: FEATURE: with PROTOCOL_DEBUG
INFO-xpp: FEATURE: with sync_tick() from DAHDI
INFO-xpp_usb: revision Unknown
usbcore: registered new driver xpp_usb
dahdi: Registered tone zone 0 (United States / North America)
dahdi_echocan_mg2: Registered echo canceler 'MG2'
eth0: no IPv6 routers present
Bluetooth: Core ver 2.10
NET: Registered protocol family 31
Bluetooth: HCI device and connection manager initialized
Bluetooth: HCI socket layer initialized


/etc/asterisk/chan_dahdi.conf

---

;# Flash Operator Panel will parse this file for dahdi trunk buttons
;# AMPLABEL will be used for the display labels on the buttons

;# %c Dahdi Channel number
;# %n Line number
;# %N Line number, but restart counter
;# Example:
;# ;AMPLABEL:Channel %c - Button %n

;# For Dahdi/* buttons use the following
;# (where x=number of buttons to dislpay)
;# ;AMPWILDCARDLABEL(x):MyLabel


[channels]
language=en

; include dahdi extensions defined in FreePBX
#include dahdi-channels.conf
#include chan_dahdi_additional.conf

; XTDM20B Port #1,2 plugged into PSTN
;AMPLABEL:Channel %c - Button %n
;context=from-pstn
;signalling=fxs_ks
;faxdetect=incoming
;usecallerid=yes
;echocancel=yes
;echocancelwhenbridged=no
;echotraining=800
;group=0
;channel=1-2
context=from-pstn
signalling=fxs_ks
rxwink=300 ; Atlas seems to use long (250ms) winks
usecallerid=yes
hidecallerid=no
callwaiting=yes
usecallingpres=yes
callwaitingcallerid=yes
threewaycalling=yes
transfer=yes
canpark=yes
cancallforward=yes
callreturn=yes
echocancel=yes
echocancelwhenbridged=no
faxdetect=incoming
echotraining=800
rxgain=0.0
txgain=0.0
callgroup=1
pickupgroup=1

;Uncomment these lines if you have problems with the disconection of your analog
lines
;busydetect=yes
;busycount=3


immediate=no



/etc/asterisk/dahdi-channels.conf

---

; Autogenerated by /usr/sbin/dahdi_genconf on Wed Dec 26 23:46:40 2012
; If you edit this file and execute /usr/sbin/dahdi_genconf again,
; your manual changes will be LOST.
; Dahdi Channels Configurations (chan_dahdi.conf)
;
; This is not intended to be a complete chan_dahdi.conf. Rather, it is intended
; to be #include-d by /etc/chan_dahdi.conf that will include the global settings
;

; Span 1: WCTDM/4 "Wildcard TDM400P REV E/F Board 5" (MASTER)
;;; line="1 WCTDM/4/0 FXSKS (In use) (SWEC: MG2)"
signalling=fxs_ks
callerid=asreceived
group=0
context=from-pstn
channel => 1
callerid=
group=
context=default

;;; line="2 WCTDM/4/1 FXSKS (In use) (SWEC: MG2)"
signalling=fxs_ks
callerid=asreceived
group=0
context=from-pstn
channel => 2
callerid=
group=
context=default

;;; line="3 WCTDM/4/2 FXSKS (In use) (SWEC: MG2)"
signalling=fxs_ks
callerid=asreceived
group=0
context=from-pstn
channel => 3
callerid=
group=
context=default

;;; line="4 WCTDM/4/3 FXSKS (In use) (SWEC: MG2)"
signalling=fxs_ks
callerid=asreceived
group=0
context=from-pstn
channel => 4
callerid=
group=
context=default

I herewith attached Dahadi_tool images.

Can you setup a custom inbound rule to playback music when called in like this:
[from-pstn-1]
exten => s,1,Answer()
exten => s,2,Playback(demo-instruct)
exten => s,n,Hangup()
Then see how it works.

Phone shows busy message right away (before seeing Starting simple switch on 'DAHDI/1-1' in console) as before.

Console message are as below:

trixbox1*CLI>
-- Starting simple switch on 'DAHDI/1-1'
-- Executing [s@from-pstn-1:1] Answer("DAHDI/1-1", "") in new stack
-- Executing [s@from-pstn-1:2] Playback("DAHDI/1-1", "demo-instruct") in new stack
-- <DAHDI/1-1> Playing 'demo-instruct.gsm' (language 'en')
trixbox1*CLI> core
abort clear restart set show stop
trixbox1*CLI> core show
application applications calls channel channels channeltype channeltypes codec codecs config file function functions globals
hint hints image license locks profile settings switches sysinfo threads translation uptime version warranty
trixbox1*CLI> core show calls
1 active call
12 calls processed
-- Executing [s@from-pstn-1:3] Hangup("DAHDI/1-1", "") in new stack
== Spawn extension (from-pstn-1, s, 3) exited non-zero on 'DAHDI/1-1'
-- Hungup 'DAHDI/1-1'
trixbox1*CLI> core show calls
0 active calls
12 calls processed
trixbox1*CLI>

Version information are as below.

[trixbox1.localdomain ~]# uname -a
Linux trixbox1.localdomain 2.6.18-164.11.1.el5 #1 SMP Wed Jan 20 07:39:04 EST 2010 i686 i686 i386 GNU/Linux


[trixbox1.localdomain ~]# asterisk -V
Asterisk 1.6.0.26-FONCORE-r78


[trixbox1.localdomain ~]# dahdi_cfg -vvv
DAHDI Tools Version - 2.3.0

DAHDI Version: 2.3.0.1
Echo Canceller(s): MG2
Configuration
======================


Channel map:

Channel 01: FXS Kewlstart (Default) (Echo Canceler: mg2) (Slaves: 01)
Channel 02: FXS Kewlstart (Default) (Echo Canceler: mg2) (Slaves: 02)
Channel 03: FXS Kewlstart (Default) (Echo Canceler: mg2) (Slaves: 03)
Channel 04: FXS Kewlstart (Default) (Echo Canceler: mg2) (Slaves: 04)

4 channels to configure.

Setting echocan for channel 1 to mg2
Setting echocan for channel 2 to mg2
Setting echocan for channel 3 to mg2
Setting echocan for channel 4 to mg2
[trixbox1.localdomain ~]#