[SOLVED] B410P TE-mode HDLC Abort

Asterisk Asterisk Support
1

Hi there,

Been bumping on this issue for some time now and I haven’t found an answer yet. Keen to get some feedback if anyone of you as been through this already. I have also posted a case on Digium’s support site…

Environment: Debian 5.0.3 kernel 2.6.26-2-686
Asterisk : 1.6.11.1
Dahdi : 2.2.0.2
LibPRI : 1.4.10.2

Issue: When connecting the B410P to the NT-unit provided by our local Telco I get the following messages showing up when starting Asterisk :

[Feb 9 11:38:31] NOTICE[3808]: chan_dahdi.c:11067 pri_dchannel: PRI got event: HDLC Abort (6) on Primary D-channel of span 1
[Feb 9 11:38:31] NOTICE[3809]: chan_dahdi.c:11067 pri_dchannel: PRI got event: HDLC Abort (6) on Primary D-channel of span 2

These basically flood the console and of course the spans are not usabel either inbound or outbound

Note: I am using only the ports 1 and 2 of the card in this application case and ports 3 and 4 definitions are left commented.
Note II: When I am connectiong these ports to an ISDN-to-SIP gateway that has its ports setup as NT ports, I am not experiencing any issue and I can see the TEI being properly negotiated and I can call in/out.

Question : Do you know what is triggering this error ? I am in New Zealand where ISDN is usually carried to the customer in BRIs that could have either a static or a dynamic TEI negotiation (in my case, I have been told that the line has been provisioned to support dynamic TEI aka PtMP).

–> Troubleshooting stuff:

root@debian:/etc/dahdi# dmesg
[ 23.763000] wcb4xxp 0000:00:0b.0: Identified Wildcard B410P (controller rev 1) at 0001e080, IRQ 19
[ 23.767002] wcb4xxp 0000:00:0b.0: VPM 0/1 init: chip ver 33
[ 23.774998] wcb4xxp 0000:00:0b.0: VPM 1/1 init: chip ver 33
[ 23.788025] wcb4xxp 0000:00:0b.0: Hardware echo cancellation enabled.
[ 23.788481] wcb4xxp 0000:00:0b.0: Port 1: TE mode
[ 23.788616] wcb4xxp 0000:00:0b.0: Port 2: TE mode
[ 23.791723] wcb4xxp 0000:00:0b.0: Port 3: TE mode
[ 23.791723] wcb4xxp 0000:00:0b.0: Port 4: TE mode
[ 23.791723] wcb4xxp 0000:00:0b.0: Did not do the highestorder stuff
[ 23.878659] wcb4xxp 0000:00:0b.0: new card sync source: port 3
[ 25.134934] dahdi_echocan_mg2: Registered echo canceler ‘MG2’
[ 25.144843] dahdi: Registered tone zone 0 (United States / North America)
[ 25.985842] lp0: using parport0 (interrupt-driven).
[ 26.033841] ppdev: user-space parallel port driver
[ 30.537123] eth0: no IPv6 routers present
[ 33.110901] [drm] Initialized drm 1.1.0 20060810
[ 33.134902] ACPI: PCI Interrupt 0000:01:00.0[A] -> GSI 16 (level, low) -> IRQ 16
[ 33.134902] [drm] Initialized savage 2.4.1 20050313 on minor 0
[ 33.139639] mtrr: base(0xd2000000) is not aligned on a size(0x5000000) boundary
[ 33.142921] agpgart: Found an AGP 2.0 compliant device at 0000:00:00.0.
[ 33.142921] agpgart: Putting AGP V2 device at 0000:00:00.0 into 0x mode
[ 33.142921] agpgart: Putting AGP V2 device at 0000:01:00.0 into 0x mode
[ 57.146650] wcb4xxp 0000:00:0b.0: new card sync source: port 1
[ 1881.249712] wcb4xxp 0000:00:0b.0: VPM 0/1 init: chip ver 33
[ 1881.261570] wcb4xxp 0000:00:0b.0: VPM 1/1 init: chip ver 33
[ 1881.274136] ACPI: PCI interrupt for device 0000:00:0b.0 disabled
[ 1881.274164] wcb4xxp 0000:00:0b.0: Driver unloaded.
[ 1881.289209] dahdi: Telephony Interface Unloaded
[ 1881.348611] dahdi: Telephony Interface Registered on major 196
[ 1881.348611] dahdi: Version: 2.2.0.2
[ 1881.375659] wcb4xxp 0000:00:0b.0: probe called for b4xx…
[ 1881.375724] ACPI: PCI Interrupt 0000:00:0b.0[A] -> GSI 19 (level, low) -> IRQ 19
[ 1881.375865] wcb4xxp 0000:00:0b.0: Identified Wildcard B410P (controller rev 1) at 0001e080, IRQ 19
[ 1881.376320] wcb4xxp 0000:00:0b.0: VPM 0/1 init: chip ver 33
[ 1881.388332] wcb4xxp 0000:00:0b.0: VPM 1/1 init: chip ver 33
[ 1881.399046] wcb4xxp 0000:00:0b.0: Hardware echo cancellation enabled.
[ 1881.400400] wcb4xxp 0000:00:0b.0: Port 1: TE mode
[ 1881.400400] wcb4xxp 0000:00:0b.0: Port 2: TE mode
[ 1881.400400] wcb4xxp 0000:00:0b.0: Port 3: TE mode
[ 1881.400400] wcb4xxp 0000:00:0b.0: Port 4: TE mode
[ 1881.400668] wcb4xxp 0000:00:0b.0: Did not do the highestorder stuff
[ 1881.503604] wcb4xxp 0000:00:0b.0: new card sync source: port 3
[ 1881.742807] dahdi_echocan_mg2: Registered echo canceler ‘MG2’
[ 1881.746780] dahdi: Registered tone zone 0 (United States / North America)
[ 1881.806800] wcb4xxp 0000:00:0b.0: new card sync source: port 1
[ 2118.394516] wcb4xxp 0000:00:0b.0: VPM 0/1 init: chip ver 33
[ 2118.405855] wcb4xxp 0000:00:0b.0: VPM 1/1 init: chip ver 33
[ 2118.418385] ACPI: PCI interrupt for device 0000:00:0b.0 disabled
[ 2118.418427] wcb4xxp 0000:00:0b.0: Driver unloaded.
[ 2118.431101] dahdi: Telephony Interface Unloaded
[ 2118.476395] dahdi: Telephony Interface Registered on major 196
[ 2118.476395] dahdi: Version: 2.2.0.2
[ 2118.492404] wcb4xxp 0000:00:0b.0: probe called for b4xx…
[ 2118.492404] ACPI: PCI Interrupt 0000:00:0b.0[A] -> GSI 19 (level, low) -> IRQ 19
[ 2118.492404] wcb4xxp 0000:00:0b.0: Identified Wildcard B410P (controller rev 1) at 0001e080, IRQ 19
[ 2118.492404] wcb4xxp 0000:00:0b.0: VPM 0/1 init: chip ver 33
[ 2118.504617] wcb4xxp 0000:00:0b.0: VPM 1/1 init: chip ver 33
[ 2118.516593] wcb4xxp 0000:00:0b.0: Hardware echo cancellation enabled.
[ 2118.516593] wcb4xxp 0000:00:0b.0: Port 1: TE mode
[ 2118.516593] wcb4xxp 0000:00:0b.0: Port 2: TE mode
[ 2118.516593] wcb4xxp 0000:00:0b.0: Port 3: TE mode
[ 2118.516593] wcb4xxp 0000:00:0b.0: Port 4: TE mode
[ 2118.516593] wcb4xxp 0000:00:0b.0: Did not do the highestorder stuff
[ 2118.618219] wcb4xxp 0000:00:0b.0: new card sync source: port 3
[ 2118.861053] dahdi_echocan_mg2: Registered echo canceler ‘MG2’
[ 2118.867435] dahdi: Registered tone zone 0 (United States / North America)
[ 2118.922937] wcb4xxp 0000:00:0b.0: new card sync source: port 1
[ 2821.152404] wcb4xxp 0000:00:0b.0: VPM 0/1 init: chip ver 33
[ 2821.161876] wcb4xxp 0000:00:0b.0: VPM 1/1 init: chip ver 33
[ 2821.174194] ACPI: PCI interrupt for device 0000:00:0b.0 disabled
[ 2821.174248] wcb4xxp 0000:00:0b.0: Driver unloaded.
[ 2821.188967] dahdi: Telephony Interface Unloaded
[ 2821.244415] dahdi: Telephony Interface Registered on major 196
[ 2821.244441] dahdi: Version: 2.2.0.2
[ 2821.270061] wcb4xxp 0000:00:0b.0: probe called for b4xx…
[ 2821.270146] ACPI: PCI Interrupt 0000:00:0b.0[A] -> GSI 19 (level, low) -> IRQ 19
[ 2821.270301] wcb4xxp 0000:00:0b.0: Identified Wildcard B410P (controller rev 1) at 0001e080, IRQ 19
[ 2821.271588] wcb4xxp 0000:00:0b.0: VPM 0/1 init: chip ver 33
[ 2821.282833] wcb4xxp 0000:00:0b.0: VPM 1/1 init: chip ver 33
[ 2821.294391] wcb4xxp 0000:00:0b.0: Hardware echo cancellation enabled.
[ 2821.294391] wcb4xxp 0000:00:0b.0: Port 1: TE mode
[ 2821.294439] wcb4xxp 0000:00:0b.0: Port 2: TE mode
[ 2821.294557] wcb4xxp 0000:00:0b.0: Port 3: TE mode
[ 2821.294675] wcb4xxp 0000:00:0b.0: Port 4: TE mode
[ 2821.295456] wcb4xxp 0000:00:0b.0: Did not do the highestorder stuff
[ 2821.396158] wcb4xxp 0000:00:0b.0: new card sync source: port 3
[ 2821.610949] dahdi_echocan_mg2: Registered echo canceler ‘MG2’
[ 2821.614963] dahdi: Registered tone zone 0 (United States / North America)
[ 2821.698961] wcb4xxp 0000:00:0b.0: new card sync source: port 1
[ 9250.242639] wcb4xxp 0000:00:0b.0: VPM 0/1 init: chip ver 33
[ 9250.254100] wcb4xxp 0000:00:0b.0: VPM 1/1 init: chip ver 33
[ 9250.266631] ACPI: PCI interrupt for device 0000:00:0b.0 disabled
[ 9250.266680] wcb4xxp 0000:00:0b.0: Driver unloaded.
[ 9250.284286] dahdi: Telephony Interface Unloaded
[ 9250.340256] dahdi: Telephony Interface Registered on major 196
[ 9250.340276] dahdi: Version: 2.2.0.2
[ 9250.370769] wcb4xxp 0000:00:0b.0: probe called for b4xx…
[ 9250.370845] ACPI: PCI Interrupt 0000:00:0b.0[A] -> GSI 19 (level, low) -> IRQ 19
[ 9250.371001] wcb4xxp 0000:00:0b.0: Identified Wildcard B410P (controller rev 1) at 0001e080, IRQ 19
[ 9250.372252] wcb4xxp 0000:00:0b.0: VPM 0/1 init: chip ver 33
[ 9250.382304] wcb4xxp 0000:00:0b.0: VPM 1/1 init: chip ver 33
[ 9250.393800] wcb4xxp 0000:00:0b.0: Hardware echo cancellation enabled.
[ 9250.396012] wcb4xxp 0000:00:0b.0: Port 1: TE mode
[ 9250.396140] wcb4xxp 0000:00:0b.0: Port 2: TE mode
[ 9250.396250] wcb4xxp 0000:00:0b.0: Port 3: TE mode
[ 9250.396250] wcb4xxp 0000:00:0b.0: Port 4: TE mode
[ 9250.397046] wcb4xxp 0000:00:0b.0: Did not do the highestorder stuff
[ 9250.495513] wcb4xxp 0000:00:0b.0: new card sync source: port 3
[ 9251.753507] dahdi_echocan_mg2: Registered echo canceler ‘MG2’
[ 9251.757834] dahdi: Registered tone zone 0 (United States / North America)
[ 9290.864455] wcb4xxp 0000:00:0b.0: new card sync source: port 1

Looks a bit chaotic to me but fair enough since it ends up with the clock source set to port 1 and ports listed as TE…

root@debian:/etc/dahdi# lsdahdi

Span 1: B4/0/1 “B4XXP (PCI) Card 0 Span 1” (MASTER) AMI/CCS

1 BRI Clear (SWEC: MG2)
2 BRI Clear (SWEC: MG2)
3 BRI Hardware-assisted HDLC

Span 2: B4/0/2 “B4XXP (PCI) Card 0 Span 2” AMI/CCS

4 BRI Clear (SWEC: MG2)
5 BRI Clear (SWEC: MG2)
6 BRI Hardware-assisted HDLC

Span 3: B4/0/3 “B4XXP (PCI) Card 0 Span 3” RED

7 BRI RED
8 BRI RED
9 BRI RED

Span 4: B4/0/4 “B4XXP (PCI) Card 0 Span 4” RED

10 BRI RED
11 BRI RED
12 BRI RED

root@debian:/etc/dahdi# dahdi_scan
[1]
active=yes
alarms=OK
description=B4XXP (PCI) Card 0 Span 1
name=B4/0/1
manufacturer=Digium
devicetype=Wildcard B410P
location=PCI Bus 00 Slot 12
basechan=1
totchans=3
irq=19
type=digital-TE
syncsrc=0
lbo=0 db (CSU)/0-133 feet (DSX-1)
coding_opts=B8ZS,AMI,HDB3
framing_opts=ESF,D4,CCS,CRC4
coding=AMI
framing=CCS
[2]
active=yes
alarms=OK
description=B4XXP (PCI) Card 0 Span 2
name=B4/0/2
manufacturer=Digium
devicetype=Wildcard B410P
location=PCI Bus 00 Slot 12
basechan=4
totchans=3
irq=19
type=digital-TE
syncsrc=0
lbo=0 db (CSU)/0-133 feet (DSX-1)
coding_opts=B8ZS,AMI,HDB3
framing_opts=ESF,D4,CCS,CRC4
coding=AMI
framing=CCS
[3]
active=yes
alarms=RED
description=B4XXP (PCI) Card 0 Span 3
name=B4/0/3
manufacturer=Digium
devicetype=Wildcard B410P
location=PCI Bus 00 Slot 12
basechan=7
totchans=3
irq=19
type=digital-TE
syncsrc=0
lbo=0 db (CSU)/0-133 feet (DSX-1)
coding_opts=B8ZS,AMI,HDB3
framing_opts=ESF,D4,CCS,CRC4
coding=
framing=
[4]
active=yes
alarms=RED
description=B4XXP (PCI) Card 0 Span 4
name=B4/0/4
manufacturer=Digium
devicetype=Wildcard B410P
location=PCI Bus 00 Slot 12
basechan=10
totchans=3
irq=19
type=digital-TE
syncsrc=0
lbo=0 db (CSU)/0-133 feet (DSX-1)
coding_opts=B8ZS,AMI,HDB3
framing_opts=ESF,D4,CCS,CRC4
coding=
framing=

root@debian:/etc/asterisk# cat dahdi-channels.conf
; Span 1: B4/0/1 “B4XXP (PCI) Card 0 Span 1” (MASTER) AMI/CCS RED
group=0,11
context=bri_trunk
switchtype = euroisdn
signalling = bri_cpe_ptmp
channel => 1-2
context = default
group = 63

; Span 2: B4/0/2 “B4XXP (PCI) Card 0 Span 2” AMI/CCS RED
group=0,12
context=bri_trunk
switchtype = euroisdn
signalling = bri_cpe_ptmp
channel => 4-5
context = default
group = 63

; Span 3: B4/0/3 “B4XXP (PCI) Card 0 Span 3” AMI/CCS RED
;group=0,13
;context=bri_trunk
;switchtype = euroisdn
;signalling = bri_cpe_ptmp
;channel => 7-8
;context = default
;group = 63

; Span 4: B4/0/4 “B4XXP (PCI) Card 0 Span 4” AMI/CCS RED
;group=0,14
;context=bri_trunk
;switchtype = euroisdn
;signalling = bri_cpe_ptmp
;channel => 10-11
;context = default
;group = 63

; Span 5: WCT1/0 “Wildcard TE122 Card 0” HDB3/CCS/CRC4 ClockSource
;group=0,15
;context=from-pstn
;switchtype = euroisdn
;signalling = pri_cpe
;channel => 13-27,29-43
;context = default
;group = 63

I think that the /etc configs are fine since I can use these spans (+ the TE120P card) when connecting with gateways… I must have missed something somewhere.

Keen to know what’s going on there. If anyone has clues or pointers… please let me know if you need more info.

Cheers,

Guillaume./.

EDIT: issue could be with the ISDN carrier. Getting this checked and confirmed.
EDIT 2: Tested with dahdi-linux-complete-2.2.1+2.2.1 : same results

2

Just replying to myself while investigating this further.

Looking into some HDLC documentation http://www.erg.abdn.ac.uk/users/gorry/eg3567/dl-pages/hdlc-framing.html and taking into account that the HDLC Abort frame is : 01111111 , it sort of makes sense that the BRIs are showing a Green Alarm as they are probably sychronized against that periodic “0”.

Given that “1’s” correspond to a zero voltage on the ISDN line… these HDLC Abort messages seem to translate into “I have got clocking from the network but this line is silent…” (sort of)

If anyone can confirm what I am understanding here, that would be nice.

My conclusion for now is that our line has NOT been properly commissioned. If anyone had a similar experience and symptoms, please let me know.

Cheers,

G./.

3

Fault was actually with the cabling which had an earth somewhere.

Weirdly enough, the spans could pick up a sync or at least showed up solid green. A legacy PBX would get there too.

the carrier’s termination Unit was also showing sync with both ends.