[prev in list] [next in list] [prev in thread] [next in thread]
List: linux1394-devel
Subject: Re: [PATCH] Re: OHCI and "unsolicited response packet received"
From: Steve Kinneberg <kinnebergsteve () acmsystems ! com>
Date: 2004-01-29 23:02:35
Message-ID: 1075417355.6592.116.camel () stevek ! sncorp ! intranet ! com
[Download RAW message or body]
On Thu, 2004-01-29 at 14:01, Phillip Michael Jordan wrote:
> Steve Kinneberg wrote:
> > On Thu, 2004-01-29 at 09:48, Phillip Michael Jordan wrote:
> >
> > >
> > > If it does:
> > > I've tried the patch against revision 1110, and revision 1111 (which
> > > seems to already have the patch applied), against 2.6.2-rc2.
> >
> >
> > The patch has not been committed to the svn repository yet. The patch
> > was actually made against revision 1111. The patch may not work
> > properly under 2.6 as I haven't tested the 2.6 changes (haven't had the
> > time to setup a 2.6 machine). There may be some differences between 2.4
> > and 2.6 that I haven't taken into account.
>
> OK, I've compiled 2.4.24 and tried it under config-rom-2.4 rev 1111
> (that branch appears to be what the patch is to be used against) that
> now, with "excessive debug output".
> I could do the same under 2.6.2-rc2, but I figured 2.4 will be more
> helpful if that's what you're using.
>
> The problem still appears, I get about 5 or 6 unsolicited responses. The
> first one comes about 15 seconds after mounting and some copying of
> files, the last one appears two seconds later, very shortly before it
> dies, and the SCSI errors appear.
>
> I've attached the (hopefully) relevant parts of /var/log/messages, but I
> suspect you will want the whole shebang (4436 lines), so I've put it on
> the web at
> http://www-users.york.ac.uk/~pmj110/linux/messages.txt.gz
> The attached bit starts at line 3677, sbp2 dies shortly after.
>
> Sorry about the huge volume of logs, I'm not really sure what you need.
>
> Note that I don't actually know if this issue is actually related to the
> packet ordering code, and not some other part, but the unsolicited
> responses start suspiciously shortly before sbp2 dies.
You have a lot of bus resets in your log (6 resets within 3 seconds).
That's a pretty bad sign to begin with. Your sbp2 device appears to be
node 0xffc0 in the logs. The selfid packets indicate that it is the
source of the bus resets.
I'm not familiar with the SBP2 protocol, so I don't know all the
conditions under which sbp2 devices are supposed to issue bus reset. My
guess is that either the sbp2 device is getting stuck in a situation
where it thinks it should issue a bus reset, or you may have a
cabling/connector problem.
All the "unsolicited messages" do appear to be truly unsolicited.
>
> If you need any more info, let me know.
>
> Cheers,
> Phil
>
> ______________________________________________________________________
> Jan 29 21:26:52 cycloid kernel: ohci1394_0: SelfID interrupt received (phyid 1, \
> root)
> Jan 29 21:26:52 cycloid kernel: ohci1394_0: SelfID packet 0x807f8066 received
> Jan 29 21:26:52 cycloid kernel: ieee1394: Including SelfID 0x66807f80
> Jan 29 21:26:52 cycloid kernel: ohci1394_0: SelfID packet 0x817f88c0 received
> Jan 29 21:26:52 cycloid kernel: ieee1394: Including SelfID 0xc0887f81
> Jan 29 21:26:52 cycloid kernel: ohci1394_0: SelfID for this node is 0x817f88c0
> Jan 29 21:26:52 cycloid kernel: ohci1394_0: SelfID complete
> Jan 29 21:26:52 cycloid kernel: ohci1394_0: PhyReqFilter=ffffffffffffffff
> Jan 29 21:26:52 cycloid kernel: ieee1394: selfid_complete called with successful \
> SelfID stage ... irm_id: 0xFFC1 node_id: 0xFFC1
> Jan 29 21:26:52 cycloid kernel: ohci1394_0: Cycle master enabled
> Jan 29 21:26:52 cycloid kernel: ieee1394: NodeMgr: Processing host reset for \
> knodemgrd_0
> Jan 29 21:26:52 cycloid kernel: ohci1394_0: Single packet rcv'd
> Jan 29 21:26:52 cycloid kernel: ohci1394_0: Got phy packet ctx=0 ... discarded
> Jan 29 21:26:52 cycloid kernel: ohci1394_0: Single packet rcv'd
> Jan 29 21:26:52 cycloid kernel: ohci1394_0: Packet received from node 0 ack=0x11 \
> spd=2 tcode=0x2 length=16 ctx=0 tlabel=56
> Jan 29 21:26:52 cycloid kernel: ieee1394: received packet: ffc1b520 ffc00000 \
> 00000000
> Jan 29 21:26:52 cycloid kernel: ieee1394: unsolicited response packet received - no \
> tlabel match
> Jan 29 21:26:52 cycloid kernel: ieee1394: contents: ffc1b520 ffc00000 00000000 \
> 9451e2a3
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet 400: ffc0bd50 ffc1ffff \
> f0000400 00140000
> Jan 29 21:26:53 cycloid kernel: ohci1394_0: Inserting packet for node 0-00:1023, \
> tlabel=47, tcode=0x5, speed=2
> Jan 29 21:26:53 cycloid kernel: ohci1394_0: Starting transmit DMA ctx=0
> Jan 29 21:26:53 cycloid kernel: ohci1394_0: IntEvent: 00000001
> Jan 29 21:26:53 cycloid kernel: ohci1394_0: Got reqTxComplete interrupt \
> status=0x00008052
> Jan 29 21:26:53 cycloid kernel: ohci1394_0: Packet sent to node 0 tcode=0x5 \
> tLabel=0x2F ack=0x12 spd=2 data=0x00140000 ctx=0
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet 400: ffc0c140 ffc1ffff \
> f0000400
> Jan 29 21:26:53 cycloid kernel: ohci1394_0: Inserting packet for node 0-00:1023, \
> tlabel=48, tcode=0x4, speed=2
> Jan 29 21:26:53 cycloid kernel: ohci1394_0: Waking transmit DMA ctx=0
> Jan 29 21:26:53 cycloid kernel: ohci1394_0: IntEvent: 00000001
> Jan 29 21:26:53 cycloid kernel: ohci1394_0: Got reqTxComplete interrupt \
> status=0x00008052
> Jan 29 21:26:53 cycloid kernel: ohci1394_0: Packet sent to node 0 tcode=0x4 \
> tLabel=0x30 ack=0x12 spd=2 data=0x00000000 ctx=0
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet local: ffc1cd50 ffc1ffff \
> f0000400 00140000
> Jan 29 21:26:53 cycloid kernel: ieee1394: received packet: ffc1cd50 ffc1ffff \
> f0000400 00140000
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet local: ffc1cd70 ffc10000 \
> 00000000 00140000
> Jan 29 21:26:53 cycloid kernel: ieee1394: received packet: ffc1cd70 ffc10000 \
> 00000000 00140000
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet local: ffc1d140 ffc1ffff \
> f0000414
> Jan 29 21:26:53 cycloid kernel: ieee1394: received packet: ffc1d140 ffc1ffff \
> f0000414
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet local: ffc1d160 ffc10000 \
> 00000000 62490400
> Jan 29 21:26:53 cycloid kernel: ieee1394: received packet: ffc1d160 ffc10000 \
> 00000000 62490400
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet local: ffc1d540 ffc1ffff \
> f0000418
> Jan 29 21:26:53 cycloid kernel: ieee1394: received packet: ffc1d540 ffc1ffff \
> f0000418
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet local: ffc1d560 ffc10000 \
> 00000000 c04f4803
> Jan 29 21:26:53 cycloid kernel: ieee1394: received packet: ffc1d560 ffc10000 \
> 00000000 c04f4803
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet local: ffc1d940 ffc1ffff \
> f000041c
> Jan 29 21:26:53 cycloid kernel: ieee1394: received packet: ffc1d940 ffc1ffff \
> f000041c
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet local: ffc1d960 ffc10000 \
> 00000000 03000081
> Jan 29 21:26:53 cycloid kernel: ieee1394: received packet: ffc1d960 ffc10000 \
> 00000000 03000081
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet local: ffc1dd40 ffc1ffff \
> f0000420
> Jan 29 21:26:53 cycloid kernel: ieee1394: received packet: ffc1dd40 ffc1ffff \
> f0000420
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet local: ffc1dd60 ffc10000 \
> 00000000 c083000c
> Jan 29 21:26:53 cycloid kernel: ieee1394: received packet: ffc1dd60 ffc10000 \
> 00000000 c083000c
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet local: ffc1e140 ffc1ffff \
> f0000424
> Jan 29 21:26:53 cycloid kernel: ieee1394: received packet: ffc1e140 ffc1ffff \
> f0000424
> Jan 29 21:26:53 cycloid kernel: ieee1394: send packet local: ffc1e160 ffc10000 \
> 00000000 090000d1
> Jan 29 21:26:53 cycloid kernel: ieee1394: received packet: ffc1e160 ffc10000 \
> 00000000 090000d1
> Jan 29 21:26:53 cycloid kernel: ieee1394: Node removed: ID:BUS[0-00:1023] \
> GUID[00d04b31e00d1050]
> Jan 29 21:26:54 cycloid kernel: ieee1394: sbp2: Logged out of SBP-2 device
> Jan 29 21:26:54 cycloid kernel: ieee1394: NodeMgr: /sbin/hotplug remove \
> 00d04b31e00d1050
> Jan 29 21:26:54 cycloid kernel: SCSI disk error : host 1 channel 0 id 0 lun 0 \
> return code = 10000
> Jan 29 21:26:54 cycloid kernel: I/O error: dev 08:05, sector 75056
--
Steve Kinneberg
ACM Systems
(916) 463-7987
kinnebergsteve at acmsystems dot com
-------------------------------------------------------
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-devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/linux1394-devel
[prev in list] [next in list] [prev in thread] [next in thread]
Configure |
About |
News |
Add a list |
Sponsored by KoreLogic