[asterisk-users] Xorcom BRI state NOTOPEN

Loic Didelot ldidelot at mixvoip.com
Wed Dec 31 10:43:26 CST 2008 

Disabling one span did only postpone the problem after a few hours the
device disconnected again.

Here the cat of /var/log/kern.log:
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.049350] usb 7-5: USB
disconnect, address 3
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.054956] INFO-xpp: XBUS-01:
[] Disconnecting
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.055065] INFO-xpp: XBUS-01:
[] Removing
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.055070] INFO-xpp:
XBUS-01/XPD-00: Remove
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.055074] NOTICE-xpp:
XBUS-01/XPD-00: Already unregistered
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.055084] INFO-xpp:
XBUS-01/XPD-01: Remove
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.055087] NOTICE-xpp:
XBUS-01/XPD-01: Already unregistered
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.055095] INFO-xpp:
XBUS-01/XPD-02: Remove
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.055098] NOTICE-xpp:
XBUS-01/XPD-02: Already unregistered
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.055106] INFO-xpp:
XBUS-01/XPD-03: Remove
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.055109] NOTICE-xpp:
XBUS-01/XPD-03: Already unregistered
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.055118] INFO-xpp:
XBUS-01/XPD-10: Remove
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.055121] NOTICE-xpp:
XBUS-01/XPD-10: Already unregistered
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.055193] INFO-xpp_usb: xusb-0
(usb-0000:00:1d.7-5) []: now disconnected
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.334145] usb 7-5: new high
speed USB device using ehci_hcd and address 4
Dec 31 00:03:33 wedekindpbx1 kernel: [12211.484673] usb 7-5:
configuration #1 chosen from 1 choice
Dec 31 00:03:34 wedekindpbx1 kernel: [12211.613467] usb 7-5: reset high
speed USB device using ehci_hcd and address 4
Dec 31 00:03:34 wedekindpbx1 kernel: [12211.763769] INFO-xpp_usb: XUSB:
Xorcom LTD -- Astribank -- FPGA
Dec 31 00:03:34 wedekindpbx1 kernel: [12211.764775] INFO-xpp: XBUS-01:
[] Activating
Dec 31 00:03:34 wedekindpbx1 kernel: [12211.765016] INFO-xpp: XBUS-01:
DESCRIPTOR: 2 cards, protocol revision 30
Dec 31 00:03:34 wedekindpbx1 kernel: [12211.765024] INFO-xpp: XBUS-01:
CARD 0 type=3.0 ports=4 (1x4), port-dir=0xF0
Dec 31 00:03:34 wedekindpbx1 kernel: [12211.765030] INFO-xpp: XBUS-01:
CARD 1 type=1.1 ports=8 (8x1), port-dir=0xFF
Dec 31 00:03:41 wedekindpbx1 kernel: [12218.666827] INFO-xpp:
XBUS-01/XPD-00: Initialized: BRI_TE
Dec 31 00:03:41 wedekindpbx1 kernel: [12218.666859] INFO-xpp:
XBUS-01/XPD-01: Initialized: BRI_TE
Dec 31 00:03:41 wedekindpbx1 kernel: [12218.666868] INFO-xpp:
XBUS-01/XPD-02: Initialized: BRI_TE
Dec 31 00:03:41 wedekindpbx1 kernel: [12218.666874] INFO-xpp:
XBUS-01/XPD-03: Initialized: BRI_TE
Dec 31 00:04:03 wedekindpbx1 kernel: [12240.702863] INFO-xpp:
XBUS-01/XPD-10: Initialized: FXS
Dec 31 09:58:30 wedekindpbx1 kernel: [35144.991547] usb 4-5: USB
disconnect, address 2
Dec 31 09:58:30 wedekindpbx1 kernel: [35144.991623] ERR-xpp_usb: xusb-0
(usb-0000:00:1d.7-5) []: nonzero write bulk status received: -108
(pending_writes=1)
Dec 31 09:58:30 wedekindpbx1 kernel: [35144.991714] DEBUG-ANY-xpp:
XBUS-00: dump_xframe: usb-write-error: frame_len=72. (IS_PCM)
Dec 31 09:58:30 wedekindpbx1 kernel: [35144.991718] DEBUG-ANY-xpp:
XBUS-00: dump_xframe:     1. DATALEN=72 pcm=1 slot=0 OP=0x11 XPD-00
(pos=0)
Dec 31 09:58:30 wedekindpbx1 kernel: [35144.991721]      : XPD=0-0+
(0x80) OP=0x11 LEN=72 BYTES: 48 08 11 80 33 33 00 00 FF FF FF FF FF FF
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF
FF FF FF FF FF FF FF FF FF FF 
Dec 31 09:58:30 wedekindpbx1 kernel: [35144.991998] ERR-xpp_usb:
XBUS-00: xusb_listen: usb_submit_urb failed: -19
Dec 31 09:58:30 wedekindpbx1 kernel: [35145.000323] INFO-xpp: XBUS-00:
[] Disconnecting
Dec 31 09:58:30 wedekindpbx1 kernel: [35145.000374] Zaptel: Master
changed to XBUS-00/XPD-01
Dec 31 09:58:30 wedekindpbx1 kernel: [35145.000381] Zaptel: Master
changed to XBUS-00/XPD-02
Dec 31 09:58:30 wedekindpbx1 kernel: [35145.000387] Zaptel: Master
changed to XBUS-00/XPD-03
Dec 31 09:58:30 wedekindpbx1 kernel: [35145.000507] INFO-xpp_usb: xusb-0
(usb-0000:00:1d.7-5) []: now disconnected
Dec 31 09:58:30 wedekindpbx1 kernel: [35145.279498] usb 4-5: new high
speed USB device using ehci_hcd and address 3
Dec 31 09:58:31 wedekindpbx1 kernel: [35145.430128] usb 4-5:
configuration #1 chosen from 1 choice
Dec 31 09:58:31 wedekindpbx1 kernel: [35145.558817] usb 4-5: reset high
speed USB device using ehci_hcd and address 3
Dec 31 09:58:31 wedekindpbx1 kernel: [35145.709332] INFO-xpp_usb: XUSB:
Xorcom LTD -- Astribank -- FPGA
Dec 31 09:58:31 wedekindpbx1 kernel: [35145.709441] INFO-xpp: XBUS-01:
[] Activating
Dec 31 09:58:31 wedekindpbx1 kernel: [35145.718557] INFO-xpp: XBUS-01:
DESCRIPTOR: 2 cards, protocol revision 30
Dec 31 09:58:31 wedekindpbx1 kernel: [35145.718564] INFO-xpp: XBUS-01:
CARD 0 type=3.0 ports=4 (1x4), port-dir=0xF0
Dec 31 09:58:31 wedekindpbx1 kernel: [35145.718573] INFO-xpp: XBUS-01:
CARD 1 type=1.1 ports=8 (8x1), port-dir=0xFF
Dec 31 09:58:38 wedekindpbx1 kernel: [35152.601894] INFO-xpp:
XBUS-01/XPD-00: Initialized: BRI_TE
Dec 31 09:58:38 wedekindpbx1 kernel: [35152.601905] INFO-xpp:
XBUS-01/XPD-01: Initialized: BRI_TE
Dec 31 09:58:38 wedekindpbx1 kernel: [35152.601911] INFO-xpp:
XBUS-01/XPD-02: Initialized: BRI_TE
Dec 31 09:58:38 wedekindpbx1 kernel: [35152.601917] INFO-xpp:
XBUS-01/XPD-03: Initialized: BRI_TE
Dec 31 09:58:59 wedekindpbx1 kernel: [35174.098354] INFO-xpp:
XBUS-01/XPD-10: Initialized: FXS
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.947765] usb 4-5: USB
disconnect, address 3
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.956938] INFO-xpp: XBUS-01:
[] Disconnecting
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.957047] INFO-xpp: XBUS-01:
[] Removing
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.957051] INFO-xpp:
XBUS-01/XPD-00: Remove
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.957056] NOTICE-xpp:
XBUS-01/XPD-00: Already unregistered
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.957068] INFO-xpp:
XBUS-01/XPD-01: Remove
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.957072] NOTICE-xpp:
XBUS-01/XPD-01: Already unregistered
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.957080] INFO-xpp:
XBUS-01/XPD-02: Remove
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.957083] NOTICE-xpp:
XBUS-01/XPD-02: Already unregistered
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.957093] INFO-xpp:
XBUS-01/XPD-03: Remove
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.957097] NOTICE-xpp:
XBUS-01/XPD-03: Already unregistered
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.957105] INFO-xpp:
XBUS-01/XPD-10: Remove
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.957108] NOTICE-xpp:
XBUS-01/XPD-10: Already unregistered
Dec 31 17:04:09 wedekindpbx1 kernel: [60620.958617] INFO-xpp_usb: xusb-0
(usb-0000:00:1d.7-5) []: now disconnected
Dec 31 17:04:09 wedekindpbx1 kernel: [60621.236110] usb 4-5: new high
speed USB device using ehci_hcd and address 4
Dec 31 17:04:09 wedekindpbx1 kernel: [60621.386741] usb 4-5:
configuration #1 chosen from 1 choice
Dec 31 17:04:10 wedekindpbx1 kernel: [60621.515419] usb 4-5: reset high
speed USB device using ehci_hcd and address 4
Dec 31 17:04:10 wedekindpbx1 kernel: [60621.665942] INFO-xpp_usb: XUSB:
Xorcom LTD -- Astribank -- FPGA
Dec 31 17:04:10 wedekindpbx1 kernel: [60621.666049] INFO-xpp: XBUS-01:
[] Activating
Dec 31 17:04:10 wedekindpbx1 kernel: [60621.675167] INFO-xpp: XBUS-01:
DESCRIPTOR: 2 cards, protocol revision 30
Dec 31 17:04:10 wedekindpbx1 kernel: [60621.675175] INFO-xpp: XBUS-01:
CARD 0 type=3.0 ports=4 (1x4), port-dir=0xF0
Dec 31 17:04:10 wedekindpbx1 kernel: [60621.675182] INFO-xpp: XBUS-01:
CARD 1 type=1.1 ports=8 (8x1), port-dir=0xFF
Dec 31 17:04:17 wedekindpbx1 kernel: [60628.558517] INFO-xpp:
XBUS-01/XPD-00: Initialized: BRI_TE
Dec 31 17:04:17 wedekindpbx1 kernel: [60628.558528] INFO-xpp:
XBUS-01/XPD-01: Initialized: BRI_TE
Dec 31 17:04:17 wedekindpbx1 kernel: [60628.558534] INFO-xpp:
XBUS-01/XPD-02: Initialized: BRI_TE
Dec 31 17:04:17 wedekindpbx1 kernel: [60628.558540] INFO-xpp:
XBUS-01/XPD-03: Initialized: BRI_TE
Dec 31 17:04:38 wedekindpbx1 kernel: [60649.965190] INFO-xpp:
XBUS-01/XPD-10: Initialized: FXS
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.202017] usb 4-5: USB
disconnect, address 4
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206210] INFO-xpp: XBUS-01:
[] Disconnecting
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206322] INFO-xpp: XBUS-01:
[] Removing
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206326] INFO-xpp:
XBUS-01/XPD-00: Remove
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206330] NOTICE-xpp:
XBUS-01/XPD-00: Already unregistered
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206342] INFO-xpp:
XBUS-01/XPD-01: Remove
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206346] NOTICE-xpp:
XBUS-01/XPD-01: Already unregistered
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206354] INFO-xpp:
XBUS-01/XPD-02: Remove
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206357] NOTICE-xpp:
XBUS-01/XPD-02: Already unregistered
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206365] INFO-xpp:
XBUS-01/XPD-03: Remove
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206368] NOTICE-xpp:
XBUS-01/XPD-03: Already unregistered
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206376] INFO-xpp:
XBUS-01/XPD-10: Remove
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206379] NOTICE-xpp:
XBUS-01/XPD-10: Already unregistered
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.206451] INFO-xpp_usb: xusb-0
(usb-0000:00:1d.7-5) []: now disconnected
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.485376] usb 4-5: new high
speed USB device using ehci_hcd and address 5
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.635985] usb 4-5:
configuration #1 chosen from 1 choice
Dec 31 17:14:47 wedekindpbx1 kernel: [61257.764693] usb 4-5: reset high
speed USB device using ehci_hcd and address 5
Dec 31 17:14:48 wedekindpbx1 kernel: [61257.915207] INFO-xpp_usb: XUSB:
Xorcom LTD -- Astribank -- FPGA
Dec 31 17:14:48 wedekindpbx1 kernel: [61257.915318] INFO-xpp: XBUS-01:
[] Activating
Dec 31 17:14:48 wedekindpbx1 kernel: [61257.915577] INFO-xpp: XBUS-01:
DESCRIPTOR: 2 cards, protocol revision 30
Dec 31 17:14:48 wedekindpbx1 kernel: [61257.915586] INFO-xpp: XBUS-01:
CARD 0 type=3.0 ports=4 (1x4), port-dir=0xF0
Dec 31 17:14:48 wedekindpbx1 kernel: [61257.915591] INFO-xpp: XBUS-01:
CARD 1 type=1.1 ports=8 (8x1), port-dir=0xFF
Dec 31 17:14:54 wedekindpbx1 kernel: [61264.807773] INFO-xpp:
XBUS-01/XPD-00: Initialized: BRI_TE
Dec 31 17:14:54 wedekindpbx1 kernel: [61264.807782] INFO-xpp:
XBUS-01/XPD-01: Initialized: BRI_TE
Dec 31 17:14:54 wedekindpbx1 kernel: [61264.807791] INFO-xpp:
XBUS-01/XPD-02: Initialized: BRI_TE
Dec 31 17:14:54 wedekindpbx1 kernel: [61264.807798] INFO-xpp:
XBUS-01/XPD-03: Initialized: BRI_TE
Dec 31 17:15:16 wedekindpbx1 kernel: [61285.845372] INFO-xpp:
XBUS-01/XPD-10: Initialized: FXS



Best regards,
Loic.


On Wed, 2008-12-31 at 08:34 +0100, Loic Didelot wrote:
> Hi,
> on span was complaining about D channels. So I disabled that port in my
> zapata.conf and since then the device does not seem to "unload" itself,
> at least it did not happen during the last 8 hours.
> 
> 
> 
> Loic
> 
> 
> 
> On Tue, 2008-12-30 at 20:37 +0200, Tzafrir Cohen wrote:
> > On Tue, Dec 30, 2008 at 05:34:32PM +0100, Loic Didelot wrote:
> > > Hello,
> > > I recently got a problem I have never seen during my previous
> > > installations.
> > > 
> > > I have a Xorcom device with 4 BRI and 8 FXS ports. I use ubuntu Linux
> > > and asterisk 1.4.22. Everything works fine but after some time zap
> > > channels disappear in asterisk.
> > > 
> > > 
> > > root at pbx1:~# cat /proc/zaptel/*
> > > Span 1: XBUS-00/XPD-00 "Xorcom XPD #00/00: BRI_TE" AMI/CCS NOTOPEN
> > > 
> > > 	   1 XPP_BRI_TE/00/00/0 Clear NOTOPEN
> > > 	   2 XPP_BRI_TE/00/00/1 Clear NOTOPEN
> > > 	   3 XPP_BRI_TE/00/00/2 HDLCFCS (In use) NOTOPEN
> > 
> > A Xorcom Astribank span will have the NOTOPEN alarm if the device itself
> > has been disconnected.
> > 
> > Do you see any kernel messages at the time of the disconnect? I expect
> > to see something about a USB device disconnected.
> > 
> > > Span 2: XBUS-00/XPD-01 "Xorcom XPD #00/01: BRI_TE" AMI/CCS NOTOPEN
> > > 
> > > 	   4 XPP_BRI_TE/00/01/0 Clear NOTOPEN
> > > 	   5 XPP_BRI_TE/00/01/1 Clear NOTOPEN
> > > 	   6 XPP_BRI_TE/00/01/2 HDLCFCS (In use) NOTOPEN
> > > Span 3: XBUS-00/XPD-02 "Xorcom XPD #00/02: BRI_TE" AMI/CCS NOTOPEN
> > > 
> > > 	   7 XPP_BRI_TE/00/02/0 Clear NOTOPEN
> > > 	   8 XPP_BRI_TE/00/02/1 Clear NOTOPEN
> > > 	   9 XPP_BRI_TE/00/02/2 HDLCFCS (In use) NOTOPEN
> > > Span 4: XBUS-00/XPD-03 "Xorcom XPD #00/03: BRI_TE" (MASTER) AMI/CCS
> > > NOTOPEN
> > > 
> > > 	  10 XPP_BRI_TE/00/03/0 Clear NOTOPEN
> > > 	  11 XPP_BRI_TE/00/03/1 Clear NOTOPEN
> > > 	  12 XPP_BRI_TE/00/03/2 HDLCFCS (In use) NOTOPEN
> > > Span 5: XBUS-00/XPD-10 "Xorcom XPD #00/10: FXS" NOTOPEN
> > > 
> > > 	  13 XPP_FXS/00/10/0 FXOKS NOTOPEN
> > > 	  14 XPP_FXS/00/10/1 FXOKS NOTOPEN
> > > 	  15 XPP_FXS/00/10/2 FXOKS NOTOPEN
> > > 	  16 XPP_FXS/00/10/3 FXOKS NOTOPEN
> > > 	  17 XPP_FXS/00/10/4 FXOKS NOTOPEN
> > > 	  18 XPP_FXS/00/10/5 FXOKS NOTOPEN
> > > 	  19 XPP_FXS/00/10/6 FXOKS NOTOPEN
> > > 	  20 XPP_FXS/00/10/7 FXOKS NOTOPEN
> > 
> > This is really odd. I would have expected at least FXS/FXO channels to
> > be immediately destroyed in response to ZT_EVENT_REMOVED / 
> > DAHDI_EVENT_REMOVED generated on that channel at disconnect time.
> > 
> > What is the output of:
> > 
> >   zaptel_hardware -v
> > 
> > at this time?
> > 
> -- 
> Loïc DIDELOT
> MIXvoip S.a.
> Tel: +352 20 3333 20
> Fax: +352 20 3333 90
> ldidelot at mixvoip.com
> http://www.mixvoip.com
> 
> 
> _______________________________________________
> -- Bandwidth and Colocation Provided by http://www.api-digital.com --
> 
> asterisk-users mailing list
> To UNSUBSCRIBE or update options visit:
>    http://lists.digium.com/mailman/listinfo/asterisk-users
-- 
Loïc DIDELOT
MIXvoip S.a.
Tel: +352 20 3333 20
Fax: +352 20 3333 90
ldidelot at mixvoip.com
http://www.mixvoip.com

More information about the asterisk-users mailing list