Is my Firewire Drive System faulty?

Hi. Can somebody understand and explain to me what's going on with my
firewire drives? I have a system (Mandrake 9.2 mandrake kernel 2.4.22-21) with five
PCI firewire cards and two 5-drive RAID arrays coming from the PCI cards.

Every time I boot up, I am getting a bunch of errors. They don't seem to
affect performance, but over the past 4 months I have had a couple of problems
with my RAIDs developing a failed drive and I'm wondering if it's related to what
is shown here -- particularly the "errors reconnecting to SBP-2 device" and a
message near the end when I'm seeing "The root node is not cycle master
capable" (something I'm seeing now but not a couple of days ago).

I would value the opinion of anyone who is knowledgeable.

Here are the logs:

FROM KERNEL ERRORS LOG
Jan 20 06:32:17 localhost kernel: ide: late registration of driver.
Jan 20 06:32:17 localhost kernel: hub.c: connect-debounce failed, port 1
disabled
Jan 20 06:32:17 localhost kernel: hub.c: port 4 over-current change
Jan 20 06:32:17 localhost kernel: hub.c: port 6 over-current change
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 0-00:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 0-02:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 1-00:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 1-02:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 2-00:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 2-02:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 3-00:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 3-01:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 4-00:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 4-02:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Error reconnecting to SBP-2
device - reconnect failed
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 0-00:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Error reconnecting to SBP-2
device - reconnect failed
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 0-01:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Error reconnecting to SBP-2
device - reconnect failed
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 1-00:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Error reconnecting to SBP-2
device - reconnect failed
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 1-01:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Error reconnecting to SBP-2
device - reconnect failed
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 2-00:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Error reconnecting to SBP-2
device - reconnect failed
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 2-01:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Error reconnecting to SBP-2
device - reconnect failed
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 4-00:1023: Max speed
[S400] - Max payload [2048]
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Error reconnecting to SBP-2
device - reconnect failed
Jan 20 06:32:17 localhost kernel: ieee1394: sbp2: Node 4-01:1023: Max speed
[S400] - Max payload [2048]

INFO LOG SHOWS HOW FIREWIRE DRIVES COME UP
Jan 20 06:47:44 localhost kernel: ohci1394: $Rev$ Ben Collins
<bcollins@debian.org>
Jan 20 06:47:44 localhost kernel: PCI: Found IRQ 9 for device 02:05.0
Jan 20 06:47:44 localhost kernel: PCI: Sharing IRQ 9 with 00:1d.2
Jan 20 06:47:44 localhost kernel: PCI: Sharing IRQ 9 with 00:1f.1
Jan 20 06:47:44 localhost kernel: PCI: Sharing IRQ 9 with 02:02.0
Jan 20 06:47:44 localhost kernel: ohci1394_0: OHCI-1394 1.0 (PCI): IRQ=[9]
MMIO=[feadd800-feaddfff] Max Packet=[2048]
Jan 20 06:47:44 localhost kernel: PCI: Found IRQ 3 for device 02:04.0
Jan 20 06:47:44 localhost kernel: PCI: Sharing IRQ 3 with 00:1f.3
Jan 20 06:47:44 localhost kernel: PCI: Sharing IRQ 3 with 00:1f.5
Jan 20 06:47:44 localhost kernel: ohci1394_1: OHCI-1394 1.0 (PCI): IRQ=[3]
MMIO=[feade000-feade7ff] Max Packet=[2048]
Jan 20 06:47:44 localhost kernel: PCI: Found IRQ 9 for device 02:02.0
Jan 20 06:47:44 localhost kernel: PCI: Sharing IRQ 9 with 00:1d.2
Jan 20 06:47:44 localhost kernel: PCI: Sharing IRQ 9 with 00:1f.1
Jan 20 06:47:44 localhost kernel: PCI: Sharing IRQ 9 with 02:05.0
Jan 20 06:47:44 localhost kernel: ohci1394_2: OHCI-1394 1.0 (PCI): IRQ=[9]
MMIO=[feadf000-feadf7ff] Max Packet=[2048]
Jan 20 06:47:44 localhost kernel: PCI: Found IRQ 11 for device 02:01.0
Jan 20 06:47:44 localhost kernel: ohci1394_3: OHCI-1394 1.0 (PCI): IRQ=[11]
MMIO=[feadf800-feadffff] Max Packet=[2048]
Jan 20 06:47:44 localhost kernel: PCI: Found IRQ 5 for device 02:03.0
Jan 20 06:47:44 localhost kernel: PCI: Sharing IRQ 5 with 00:1d.1
Jan 20 06:47:44 localhost kernel: ohci1394_4: OHCI-1394 1.1 (PCI): IRQ=[5]
MMIO=[feade800-feadefff] Max Packet=[2048]
Jan 20 06:47:44 localhost kernel: scsi1 : SCSI emulation for IEEE-1394 SBP-2
Devices
Jan 20 06:47:44 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 20 06:47:44 localhost kernel: /dev/scsi/host1/bus0/target0/lun0: p1
Jan 20 06:47:44 localhost kernel: ieee1394: Node added: ID:BUS[0-00:1023]
GUID[0010b920001eb161]
Jan 20 06:47:44 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 20 06:47:44 localhost kernel: /dev/scsi/host1/bus0/target1/lun0: p1
Jan 20 06:47:44 localhost kernel: ieee1394: Node added: ID:BUS[0-01:1023]
GUID[0010b92000f42454]
Jan 20 06:47:44 localhost kernel: ieee1394: Host added: ID:BUS[0-02:1023]
GUID[00309526b0086267]
Jan 20 06:47:44 localhost kernel: scsi2 : SCSI emulation for IEEE-1394 SBP-2
Devices
Jan 20 06:47:44 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 20 06:47:44 localhost kernel: /dev/scsi/host2/bus0/target0/lun0: p1
Jan 20 06:47:44 localhost kernel: ieee1394: Node added: ID:BUS[1-00:1023]
GUID[0010b920003d323a]
Jan 20 06:47:44 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 20 06:47:44 localhost kernel: /dev/scsi/host2/bus0/target1/lun0: p1
Jan 20 06:47:44 localhost kernel: ieee1394: Node added: ID:BUS[1-01:1023]
GUID[0010b92000899f84]
Jan 20 06:47:44 localhost kernel: ieee1394: Host added: ID:BUS[1-02:1023]
GUID[230050c500010511]
Jan 20 06:47:44 localhost kernel: scsi3 : SCSI emulation for IEEE-1394 SBP-2
Devices
Jan 20 06:47:44 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 20 06:47:44 localhost kernel: /dev/scsi/host3/bus0/target0/lun0: p1
Jan 20 06:47:44 localhost kernel: ieee1394: Node added: ID:BUS[2-00:1023]
GUID[0010b920003d3841]
Jan 20 06:47:44 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 20 06:47:44 localhost kernel: /dev/scsi/host3/bus0/target1/lun0: p1
Jan 20 06:47:44 localhost kernel: ieee1394: Node added: ID:BUS[2-01:1023]
GUID[0010b920001ecc5f]
Jan 20 06:47:44 localhost kernel: ieee1394: Host added: ID:BUS[2-02:1023]
GUID[0001080010021474]
Jan 20 06:47:44 localhost kernel: scsi4 : SCSI emulation for IEEE-1394 SBP-2
Devices
Jan 20 06:47:44 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 20 06:47:44 localhost kernel: /dev/scsi/host4/bus0/target0/lun0: p1
Jan 20 06:47:44 localhost kernel: ieee1394: Node added: ID:BUS[3-00:1023]
GUID[0010b920003d25d3]
Jan 20 06:47:44 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 20 06:47:44 localhost kernel: /dev/scsi/host4/bus0/target1/lun0: p1
Jan 20 06:47:44 localhost kernel: ieee1394: Node added: ID:BUS[3-01:1023]
GUID[0010b920003d565f]
Jan 20 06:47:44 localhost kernel: ieee1394: Host added: ID:BUS[3-02:1023]
GUID[00309526b0082787]
Jan 20 06:47:44 localhost kernel: scsi5 : SCSI emulation for IEEE-1394 SBP-2
Devices
Jan 20 06:47:44 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 20 06:47:45 localhost kernel: /dev/scsi/host5/bus0/target0/lun0: p1
Jan 20 06:47:45 localhost kernel: ieee1394: Node added: ID:BUS[4-00:1023]
GUID[0010b920003d25ed]
Jan 20 06:47:45 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 20 06:47:45 localhost kernel: /dev/scsi/host5/bus0/target1/lun0: p1
Jan 20 06:47:45 localhost kernel: ieee1394: Node added: ID:BUS[4-01:1023]
GUID[0010b920001ecc90]
Jan 20 06:47:45 localhost kernel: ieee1394: Host added: ID:BUS[4-02:1023]
GUID[0001080020001ddf]

a couple of days later:

Jan 22 08:13:34 localhost kernel: ohci1394: $Rev$ Ben Collins
<bcollins@debian.org>
Jan 22 08:13:34 localhost kernel: PCI: Found IRQ 9 for device 02:05.0
Jan 22 08:13:34 localhost kernel: PCI: Sharing IRQ 9 with 00:1d.2
Jan 22 08:13:34 localhost kernel: PCI: Sharing IRQ 9 with 00:1f.1
Jan 22 08:13:34 localhost kernel: PCI: Sharing IRQ 9 with 02:02.0
Jan 22 08:13:34 localhost kernel: ohci1394_0: OHCI-1394 1.0 (PCI): IRQ=[9]
MMIO=[feadd800-feaddfff] Max Packet=[2048]
Jan 22 08:13:34 localhost kernel: PCI: Found IRQ 3 for device 02:04.0
Jan 22 08:13:34 localhost kernel: PCI: Sharing IRQ 3 with 00:1f.3
Jan 22 08:13:34 localhost kernel: PCI: Sharing IRQ 3 with 00:1f.5
Jan 22 08:13:34 localhost kernel: ohci1394_1: OHCI-1394 1.0 (PCI): IRQ=[3]
MMIO=[feade000-feade7ff] Max Packet=[2048]
Jan 22 08:13:34 localhost kernel: PCI: Found IRQ 9 for device 02:02.0
Jan 22 08:13:34 localhost kernel: PCI: Sharing IRQ 9 with 00:1d.2
Jan 22 08:13:34 localhost kernel: PCI: Sharing IRQ 9 with 00:1f.1
Jan 22 08:13:34 localhost kernel: PCI: Sharing IRQ 9 with 02:05.0
Jan 22 08:13:34 localhost kernel: ohci1394_2: OHCI-1394 1.0 (PCI): IRQ=[9]
MMIO=[feadf000-feadf7ff] Max Packet=[2048]
Jan 22 08:13:34 localhost kernel: PCI: Found IRQ 11 for device 02:01.0
Jan 22 08:13:34 localhost kernel: ohci1394_3: OHCI-1394 1.0 (PCI): IRQ=[11]
MMIO=[feadf800-feadffff] Max Packet=[2048]
Jan 22 08:13:34 localhost kernel: PCI: Found IRQ 5 for device 02:03.0
Jan 22 08:13:34 localhost kernel: PCI: Sharing IRQ 5 with 00:1d.1
Jan 22 08:13:34 localhost kernel: ohci1394_4: OHCI-1394 1.1 (PCI): IRQ=[5]
MMIO=[feade800-feadefff] Max Packet=[2048]
Jan 22 08:13:34 localhost kernel: scsi1 : SCSI emulation for IEEE-1394 SBP-2
Devices
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: /dev/scsi/host1/bus0/target0/lun0: p1
Jan 22 08:13:34 localhost kernel: ieee1394: Node added: ID:BUS[0-00:1023]
GUID[0010b920001eb161]
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: /dev/scsi/host1/bus0/target1/lun0: p1
Jan 22 08:13:34 localhost kernel: ieee1394: Node added: ID:BUS[0-01:1023]
GUID[0010b92000f42454]
Jan 22 08:13:34 localhost kernel: ieee1394: Host added: ID:BUS[0-02:1023]
GUID[00309526b0086267]
Jan 22 08:13:34 localhost kernel: scsi2 : SCSI emulation for IEEE-1394 SBP-2
Devices
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: /dev/scsi/host2/bus0/target0/lun0: p1
Jan 22 08:13:34 localhost kernel: ieee1394: Node added: ID:BUS[1-00:1023]
GUID[0010b920003d323a]
Jan 22 08:13:34 localhost kernel: ieee1394: Host added: ID:BUS[1-01:1023]
GUID[230050c500010511]
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: /dev/scsi/host2/bus0/target1/lun0: p1
Jan 22 08:13:34 localhost kernel: ieee1394: Node added: ID:BUS[1-02:1023]
GUID[0010b92000899f84]
Jan 22 08:13:34 localhost kernel: ieee1394: The root node is not cycle master
capable; selecting a new root node and resetting...
Jan 22 08:13:34 localhost kernel: scsi3 : SCSI emulation for IEEE-1394 SBP-2
Devices
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: /dev/scsi/host3/bus0/target0/lun0: p1
Jan 22 08:13:34 localhost kernel: ieee1394: Node added: ID:BUS[2-00:1023]
GUID[0010b920003d3841]
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: /dev/scsi/host3/bus0/target1/lun0: p1
Jan 22 08:13:34 localhost kernel: ieee1394: Node added: ID:BUS[2-01:1023]
GUID[0010b920001ecc5f]
Jan 22 08:13:34 localhost kernel: ieee1394: Host added: ID:BUS[2-02:1023]
GUID[0001080010021474]
Jan 22 08:13:34 localhost kernel: scsi4 : SCSI emulation for IEEE-1394 SBP-2
Devices
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: /dev/scsi/host4/bus0/target0/lun0: p1
Jan 22 08:13:34 localhost kernel: ieee1394: Node added: ID:BUS[3-00:1023]
GUID[0010b920003d565f]
Jan 22 08:13:34 localhost kernel: ieee1394: Host added: ID:BUS[3-01:1023]
GUID[00309526b0082787]
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: /dev/scsi/host4/bus0/target1/lun0: p1
Jan 22 08:13:34 localhost kernel: ieee1394: Node added: ID:BUS[3-02:1023]
GUID[0010b920003d25d3]
Jan 22 08:13:34 localhost kernel: ieee1394: The root node is not cycle master
capable; selecting a new root node and resetting...
Jan 22 08:13:34 localhost kernel: scsi5 : SCSI emulation for IEEE-1394 SBP-2
Devices
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: /dev/scsi/host5/bus0/target0/lun0: p1
Jan 22 08:13:34 localhost kernel: ieee1394: Node added: ID:BUS[4-00:1023]
GUID[0010b920003d25ed]
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: /dev/scsi/host5/bus0/target1/lun0: p1
Jan 22 08:13:34 localhost kernel: ieee1394: Node added: ID:BUS[4-01:1023]
GUID[0010b920001ecc90]
Jan 22 08:13:34 localhost kernel: ieee1394: Host added: ID:BUS[4-02:1023]
GUID[0001080020001ddf]
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: ieee1394: Node changed: 1-02:1023 ->
1-01:1023
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: ieee1394: Node changed: 1-01:1023 ->
1-02:1023
Jan 22 08:13:34 localhost kernel: ieee1394: Node changed: 3-02:1023 ->
3-00:1023
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: ieee1394: Node changed: 3-00:1023 ->
3-01:1023
Jan 22 08:13:34 localhost kernel: ieee1394: sbp2: Logged into SBP-2 device
Jan 22 08:13:34 localhost kernel: ieee1394: Node changed: 3-01:1023 ->
3-02:1023

-------------------------------------------------------
The SF.Net email is sponsored by EclipseCon 2004
Premiere Conference on Open Tools Development and Integration
See the breadth of Eclipse activity. February 3-5 in Anaheim, CA.
http://www.eclipsecon.org/osdn
_______________________________________________
mailing list Linux1394-user@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/linux1394-user
Received on Sun Jan 25 13:54:42 2004