Stable/9 from today mpssas_scsiio timeouts

[Jeremy Chadwick]

On Tue, Jul 09, 2013 at 05:32:39AM -0400, Outback Dingo wrote:
> as of stable today im seeing alot of new mps time outs
> 
> 9.1-STABLE FreeBSD 9.1-STABLE #0 r253035M: Mon Jul  8 16:34:28 UTC 2013
> root@:/usr/obj/nas/usr/src/sys/
> 
> mps1 at pci0:130:0:0:      class=0x010700 card=0x30201000 chip=0x00721000
> rev=0x03 hdr=0x00
>     vendor     = 'LSI Logic / Symbios Logic'
>     device     = 'SAS2008 PCI-Express Fusion-MPT SAS-2 [Falcon]'
>     class      = mass storage
>     subclass   = SAS
> 
> 
> mps0: mpssas_scsiio_timeout checking sc 0xffffff8002145000 cm
> 0xffffff80021a6b78
> (probe40:mps0:0:40:0): INQUIRY. CDB: 12 00 00 00 24 00 length 36 SMID 983
> command timeout cm 0xffffff80021a6b78 ccb 0xfffffe002bb5f800
> mps0: mpssas_alloc_tm freezing simq
> mps0: timedout cm 0xffffff80021a6b78 allocated tm 0xffffff80021587b0
> (probe40:mps0:0:40:0): INQUIRY. CDB: 12 00 00 00 24 00 length 36 SMID 983
> completed timedout cm 0xffffff80021a6b78 ccb 0xfffffe002bb5f800 during
> recovery ioc 8048 scsi 0 state c xfer 0
> (noperiph:mps0:0:40:0): SMID 6 abort TaskMID 983 status 0x4a code 0x0 count
> 1
> (noperiph:mps0:0:40:0): SMID 6 finished recovery after aborting TaskMID 983
> mps0: mpssas_free_tm releasing simq
> (probe40:mps0:0:40:0): INQUIRY. CDB: 12 00 00 00 24 00
> (probe40:mps0:0:40:0): CAM status: Command timeout
> (probe40:mps0:0:40:0): Retrying command
> mps1: mpssas_scsiio_timeout checking sc 0xffffff8002384000 cm
> 0xffffff80023e5b78
> (probe292:mps1:0:37:0): INQUIRY. CDB: 12 00 00 00 24 00 length 36 SMID 983
> command timeout cm 0xffffff80023e5b78 ccb 0xfffffe002be14800
> mps1: mpssas_alloc_tm freezing simq
> mps1: timedout cm 0xffffff80023e5b78 allocated tm 0xffffff80023977b0
> (probe292:mps1:0:37:0): INQUIRY. CDB: 12 00 00 00 24 00 length 36 SMID 983
> completed timedout cm 0xffffff80023e5b78 ccb 0xfffffe002be14800 during
> recovery ioc 8048 scsi 0 state c xfer 0
> (noperiph:mps1:0:37:0): SMID 6 abort TaskMID 983 status 0x4a code 0x0 count
> 1
> (noperiph:mps1:0:37:0): SMID 6 finished recovery after aborting TaskMID 983
> mps1: mpssas_free_tm releasing simq
> (probe292:mps1:0:37:0): INQUIRY. CDB: 12 00 00 00 24 00
> (probe292:mps1:0:37:0): CAM status: Command timeout
> (probe292:mps1:0:37:0): Retrying command

1. What revision were you running before (i.e. what were you on prior to
the upgrade)?

2. Something in your /usr/src differs from stock r253035, hence the "M"
at the end.  What is it?

Answer to #1 will help me narrow down the commits; there have been CAM
and mps changes fairly recently.  Otherwise you can dig through the
commits yourself (you'll need to go through many, many pages, as there
was a recent massive influx of SCTP changes (50+ commits)):

http://www.freshbsd.org/?branch=RELENG_9&project=freebsd

-- 
| Jeremy Chadwick                                   jdc at koitsu.org |
| UNIX Systems Administrator                http://jdc.koitsu.org/ |
| Making life hard for others since 1977.             PGP 4BD6C0CB |