Hello,
I seem to be having an issue with the configuration of my PRI on a new
asterisk server I've created to replace an old install that I have.
The card is Digium Wildcard TE133. I continually get messages like
"Primary D-Channel on span 1 down", rather irregularly:
[2013-07-29 17:31:39] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:31:39] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:32:52] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 down
[2013-07-29 17:32:52] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 down
[2013-07-29 17:33:16] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:33:16] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:33:35] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 down
[2013-07-29 17:33:35] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 down
[2013-07-29 17:33:50] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:33:50] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:34:05] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 down
[2013-07-29 17:34:05] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 down
[2013-07-29 17:34:32] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:34:32] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:35:37] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 down
[2013-07-29 17:35:37] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 down
[2013-07-29 17:36:02] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:36:02] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:36:21] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 down
[2013-07-29 17:36:21] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 down
[2013-07-29 17:36:36] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:36:36] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:36:51] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 down
[2013-07-29 17:36:51] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 down
[2013-07-29 17:37:35] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:37:35] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
I've searched a lot regarding this problem and it seems that this
might simply be a configuration error, or an issue with the cable
(consequently, I used a straight-through cable from the PRI to the
Dahdi interface...is this correct? Or should I have used a crossover
cable? I'm waiting for a technician from my telco to contact me and
I'm sure he'll be able to give insight).
I've posted the configs and the output of a 'pri debug' below.
Please
let me know if I should include anything else to help troubleshoot.
I've tried both a standalone conifguration as well as the Dahdi module
in FreePBX, results with the same error(s).
/etc/dahdi/system.conf:
span=1,0,0,ESF,B8ZS
bchan=1-23
dchan=24
loadzone=us
/etc/asterisk/chan_dahdi.conf
[channels]
language=en
busydetect=yes
busycount=10
usecallerid=yes
callwaiting=yes
usecallingpres=yes
threewaycalling=yes
transfer=yes
cancallforward=yes
callreturn=yes
echocancel=yes
echocancelwhenbridged=no
echotraining=no
immediate=no
faxdetect=no
rxgain=0.0
txgain=0.0
[root at asterisk-master ~]# dahdi_scan
[1]
active=yes
alarms=OK
description=Wildcard TE133 Card 0
name=WCT13x/0
manufacturer=Digium
devicetype=Wildcard TE133
location=PCI Bus 01 Slot 01
basechan=1
totchans=24
irq=0
type=digital-T1
syncsrc=0
lbo=0 db (CSU)/0-133 feet (DSX-1)
coding_opts=B8ZS,AMI
framing_opts=ESF,D4
coding=B8ZS
framing=ESF
[root at asterisk-master ~]# cat /proc/interrupts
CPU0 CPU1 CPU2 CPU3 CPU4 CPU5
CPU6 CPU7
0: 124 0 0 0 0 0
0 0 IO-APIC-edge timer
1: 2 0 0 0 0 0
0 0 IO-APIC-edge i8042
3: 2 0 0 0 0 0
0 0 IO-APIC-edge
4: 2 0 0 0 0 0
0 0 IO-APIC-edge
8: 1 0 0 0 0 0
0 0 IO-APIC-edge rtc0
9: 0 0 0 0 0 0
0 0 IO-APIC-fasteoi acpi
10: 2 0 0 0 0 0
0 0 IO-APIC-edge
12: 4 0 0 0 0 0
0 0 IO-APIC-edge i8042
16: 62 0 0 0 0 0
0 0 IO-APIC-fasteoi ehci_hcd:usb1
23: 28 0 0 0 0 0
0 0 IO-APIC-fasteoi ehci_hcd:usb2
24: 37 0 0 0 0 0
0 0 HPET_MSI-edge hpet2
25: 0 0 0 0 0 0
0 0 HPET_MSI-edge hpet3
26: 0 0 0 0 0 0
0 0 HPET_MSI-edge hpet4
27: 0 0 0 0 0 0
0 0 HPET_MSI-edge hpet5
28: 0 0 0 0 0 0
0 0 HPET_MSI-edge hpet6
30: 3901 0 1772 0 335 0
7057 72283 PCI-MSI-edge ahci
31: 16 5728 195229 0 0 384
0 0 PCI-MSI-edge eth0-rx-0
32: 9 0 873 0 35631 0
0 0 PCI-MSI-edge eth0-tx-0
33: 2 0 0 0 0 0
0 0 PCI-MSI-edge eth0
34: 9 0 0 0 0 0
72688 0 PCI-MSI-edge eth1-rx-0
35: 0 0 0 0 0 0
0 0 PCI-MSI-edge eth1-tx-0
36: 2 0 0 0 0 0
0 0 PCI-MSI-edge eth1
37: 12133 10966488 0 0 19797 0
0 0 PCI-MSI-edge te13xp
NMI: 108 289 71 55 74 39
45 20 Non-maskable interrupts
LOC: 807200 255208 391913 122924 972530 324505
447505 119817 Local timer interrupts
SPU: 0 0 0 0 0 0
0 0 Spurious interrupts
PMI: 108 289 71 55 74 39
45 20 Performance monitoring interrupts
IWI: 0 0 0 0 0 0
0 0 IRQ work interrupts
RES: 2135 1762 1506 1092 2446 1307
1409 935 Rescheduling interrupts
CAL: 50 216 218 220 204 219
203 216 Function call interrupts
TLB: 8985 6881 1309 7696 4952 3427
2324 2648 TLB shootdowns
TRM: 0 0 0 0 0 0
0 0 Thermal event interrupts
THR: 0 0 0 0 0 0
0 0 Threshold APIC interrupts
MCE: 0 0 0 0 0 0
0 0 Machine check exceptions
MCP: 39 39 39 39 39 39
39 39 Machine check polls
ERR: 0
MIS: 0
Part of the logs:
[2013-07-29 17:34:32] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:34:32] VERBOSE[3621] sig_pri.c: == Primary D-Channel
on span 1 up
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
Protocol Discriminator: Q.931 (8) len=13
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
Protocol Discriminator: Q.931 (8) len=13
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 < TEI=0
Call Ref: len= 2 (reference 0/0x0) (Sent from originator)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 < TEI=0
Call Ref: len= 2 (reference 0/0x0) (Sent from originator)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
Message Type: RESTART (70)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
Message Type: RESTART (70)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 < [18 03 a9 83
81]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 < [18 03 a9 83
81]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0
Exclusive Dchan: 0
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0
Exclusive Dchan: 0
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
ChanSel: As indicated in following octets
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
ChanSel: As indicated in following octets
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
Ext: 1 Coding: 0 Number Specified Channel Type: 3
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
Ext: 1 Coding: 0 Number Specified Channel Type: 3
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
Ext: 1 Channel: 1 Type: CPE]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
Ext: 1 Channel: 1 Type: CPE]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 < [79 01 80]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 < [79 01 80]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
Restart Indicator (len= 3) [ Ext: 1 Spare: 0 Resetting Indicated
Channel (0) ]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 <
Restart Indicator (len= 3) [ Ext: 1 Spare: 0 Resetting Indicated
Channel (0) ]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 Received
message for call 0x7f6ec0000cf0 on link 0x7f6ed42fb940 TEI/SAPI 0/0
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 Received
message for call 0x7f6ec0000cf0 on link 0x7f6ed42fb940 TEI/SAPI 0/0
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 --
Processing Q.931 Restart
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 --
Processing Q.931 Restart
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 --
Processing IE 24 (cs0, Channel ID)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 --
Processing IE 24 (cs0, Channel ID)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 --
Processing IE 121 (cs0, Restart Indicator)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 --
Processing IE 121 (cs0, Restart Indicator)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1
q931.c:8580 post_handle_q931_message: Call 0 enters state 62
(Restart). Hold state: Idle
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1
q931.c:8580 post_handle_q931_message: Call 0 enters state 62
(Restart). Hold state: Idle
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1
q931.c:5358 restart_ack: Call 0 enters state 0 (Null). Hold state:
Idle
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1
q931.c:5358 restart_ack: Call 0 enters state 0 (Null). Hold state:
Idle
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 > DL-DATA
request
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 > DL-DATA
request
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Protocol Discriminator: Q.931 (8) len=13
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Protocol Discriminator: Q.931 (8) len=13
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 > TEI=0
Call Ref: len= 2 (reference 0/0x0) (Sent to originator)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 > TEI=0
Call Ref: len= 2 (reference 0/0x0) (Sent to originator)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Message Type: RESTART ACKNOWLEDGE (78)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Message Type: RESTART ACKNOWLEDGE (78)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 TEI=0
Transmitting N(S)=0, window is open V(A)=0 K=7
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 TEI=0
Transmitting N(S)=0, window is open V(A)=0 K=7
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Protocol Discriminator: Q.931 (8) len=13
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Protocol Discriminator: Q.931 (8) len=13
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 > TEI=0
Call Ref: len= 2 (reference 0/0x0) (Sent to originator)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 > TEI=0
Call Ref: len= 2 (reference 0/0x0) (Sent to originator)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Message Type: RESTART ACKNOWLEDGE (78)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Message Type: RESTART ACKNOWLEDGE (78)
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 > [18 03 a9 83
81]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 > [18 03 a9 83
81]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0
Exclusive Dchan: 0
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0
Exclusive Dchan: 0
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
ChanSel: As indicated in following octets
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
ChanSel: As indicated in following octets
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Ext: 1 Coding: 0 Number Specified Channel Type: 3
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Ext: 1 Coding: 0 Number Specified Channel Type: 3
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Ext: 1 Channel: 1 Type: CPE]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Ext: 1 Channel: 1 Type: CPE]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 > [79 01 80]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 > [79 01 80]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Restart Indicator (len= 3) [ Ext: 1 Spare: 0 Resetting Indicated
Channel (0) ]
[2013-07-29 17:34:33] VERBOSE[3621] chan_dahdi.c: PRI Span: 1 >
Restart Indicator (len= 3) [ Ext: 1 Spare: 0 Resetting Indicated
Channel (0) ]
[2013-07-29 17:34:33] VERBOSE[3621] sig_pri.c: Span 1: Processing
event PRI_EVENT_RESTART(3)
Thanks in advance for the help! Please let me know if I should
include any other info.
On Tue, Jul 30, 2013 at 10:36:58AM -0400, Andre Goree wrote:> > I seem to be having an issue with the configuration of my PRI on a new > asterisk server I've created to replace an old install that I have. > The card is Digium Wildcard TE133.In case you haven't, you should feel free to contact Digium customer support with installation assistance with your new card. http://www.digium.com/en/support/contact> I've posted the configs and the output of a 'pri debug' below. Please > let me know if I should include anything else to help troubleshoot. > I've tried both a standalone conifguration as well as the Dahdi module > in FreePBX, results with the same error(s). > > /etc/dahdi/system.conf: > span=1,0,0,ESF,B8ZS > bchan=1-23 > dchan=24 > loadzone=usI think the span line above is wrong. I think you want: span=1,1,0,esf,b8zs The second 1 indicates that the span should recover the clock from the remote side (which should be your provider). However, normally when you have the timing misconfigured like this you'll get HDLC aborts, and not just the PRI going up and down. So before looking into any more or contacting customer support, it might be easy to change that one line and see if the behavior is different. -- Shaun Ruffell Digium, Inc. | Linux Kernel Developer 445 Jan Davis Drive NW - Huntsville, AL 35806 - USA Check us out at: www.digium.com & www.asterisk.org
On 30/07/13 15:36, Andre Goree wrote:> /etc/dahdi/system.conf: > span=1,0,0,ESF,B8ZS > bchan=1-23 > dchan=24 > loadzone=us >The first '0' in your span line above indicated that asterisk is generating the timing source. Normally the network operator provides timing so I would expect this to be a '1'. This can be the cause of the issue you are seeing as each end will be using a different clock which can be out of sync or drift causing data corruption, signalling errors and the d channel going down.