Avago LSI SAS 3008 & Intel SSD Timeouts
Steven Hartland
killing at multiplay.co.uk
Tue Jun 7 21:22:42 UTC 2016
Always da6?
On 07/06/2016 21:19, list-news wrote:
> Sure Steve:
>
> # cat /boot/loader.conf | grep trim
> vfs.zfs.trim.enabled=0
>
> # sysctl vfs.zfs.trim.enabled
> vfs.zfs.trim.enabled: 0
>
> # uptime
> 3:14PM up 11 mins, 3 users, load averages: 6.58, 11.31, 7.07
>
> # tail -f /var/log/messages:
> Jun 7 15:13:50 s18 kernel: (da6:mpr0:0:16:0): WRITE(10). CDB: 2a 00
> 2b d8 86 50 00 00 b0 00 length 90112 SMID 1016 command timeout cm
> 0xfffffe0001375580 ccb 0xfffff8039895f800 target 16, handle(0x0010)
> Jun 7 15:13:50 s18 kernel: mpr0: At enclosure level 0, slot 8,
> connector name ( )
> Jun 7 15:13:50 s18 kernel: mpr0: timedout cm 0xfffffe0001375580
> allocated tm 0xfffffe0001322150
> Jun 7 15:13:50 s18 kernel: (noperiph:mpr0:0:4294967295:0): SMID 1
> Aborting command 0xfffffe0001375580
> Jun 7 15:13:50 s18 kernel: mpr0: Sending reset from mprsas_send_abort
> for target ID 16
> Jun 7 15:13:50 s18 kernel: (da6:mpr0:0:16:0): SYNCHRONIZE CACHE(10).
> CDB: 35 00 00 00 00 00 00 00 00 00 length 0 SMID 786 command timeout
> cm 0xfffffe00013627a0 ccb 0xfffff8039851e800 target 16, handle(0x0010)
> Jun 7 15:13:50 s18 kernel: mpr0: At enclosure level 0, slot 8,
> connector name ( )
> Jun 7 15:13:50 s18 kernel: mpr0: queued timedout cm
> 0xfffffe00013627a0 for processing by tm 0xfffffe0001322150
> Jun 7 15:13:50 s18 kernel: mpr0: EventReply :
> Jun 7 15:13:50 s18 kernel: EventDataLength: 2
> Jun 7 15:13:50 s18 kernel: AckRequired: 0
> Jun 7 15:13:50 s18 kernel: Event: SasDiscovery (0x16)
> Jun 7 15:13:50 s18 kernel: EventContext: 0x0
> Jun 7 15:13:50 s18 kernel: Flags: 1<InProgress>
> Jun 7 15:13:50 s18 kernel: ReasonCode: Discovery Started
> Jun 7 15:13:50 s18 kernel: PhysicalPort: 0
> Jun 7 15:13:50 s18 kernel: DiscoveryStatus: 0
> Jun 7 15:13:50 s18 kernel: (da6:mpr0:0:16:0): READ(10). CDB: 28 00 0b
> 43 a8 00 00 00 10 00 length 8192 SMID 624 completed cm
> 0xfffffe0001355300 ccb 0xfffff803984d4800 during recovery ioc 804b
> scsi 0 state c xfer 0
> Jun 7 15:13:50 s18 kernel: (da6:mpr0:0:16:0): READ(10). CDB: 28 00 0b
> 43 a8 00 00 00 10 00 length 8192 SMID 624 terminated ioc 804b scsi 0
> state c xfer 0
> Jun 7 15:13:50 s18 kernel: (da6:mpr0:0:16:0): READ(10). CDB: 28 00 0b
> 43 a7 f0 00 00 10 00 length 8192 SMID 633 completed cm
> 0xfffffe0001355ed0 ccb 0xfffff803987f0000 during recovery ioc 804b
> scsi 0 state c xfer 0
> Jun 7 15:13:50 s18 kernel: (da6:mpr0:0:16:0): READ(10). CDB: 28 00 0b
> 43 a7 f0 00 00 10 00 length 8192 SMID 633 terminated ioc 804b scsi 0
> state c xfer 0
> Jun 7 15:13:50 s18 kernel: (da6:mpr0:0:16:0): READ(10). CDB: 28 00 0a
> 25 3f f0 00 00 08 00 length 4096 SMID 133 completed cm
> 0xfffffe000132ce90 ccb 0xfffff803985fc000 during recovery ioc 804b
> scsi 0 state c xfer 0
> Jun 7 15:13:50 s18 kernel: (da6:mpr0:0:16:0): READ(10). CDB: 28 00 0a
> 25 3f f0 00 00 08 00 length 4096 SMID 133 terminated ioc 804b scsi 0
> state c xfer 0
> Jun 7 15:13:50 s18 kernel: (da6:mpr0:0:16:0): WRITE(10). CDB: 2a 00
> 2b d8 86 50 00 00 b0 00 length 90112 SMID 1016 completed timedout cm
> 0xfffffe0001375580 ccb 0xfffff8039895f800 during recovery ioc 8048
> scsi 0 state c (da6:mpr0:0:16:0): SYNCHRONIZE CACHE(10). CDB: 35 00
> 00 00 00 00 00 00 00 00 length 0 SMID 786 completed timedout cm
> 0xfffffe(da6:mpr0:0:16:0): WRITE(10). CDB: 2a 00 2b d8 86 50 00 00 b0 00
> Jun 7 15:13:50 s18 kernel: 00013627a0 ccb 0xfffff8039851e800 during
> recovery ioc 804b scsi 0 (da6:mpr0:0:16:0): CAM status: Command timeout
> Jun 7 15:13:50 s18 kernel: (da6:mpr0:0:16:0): SYNCHRONIZE CACHE(10).
> CDB: 35 00 00 00 00 00 00 00 00 00 length 0 SMID 786 terminated ioc
> 804b scsi 0 sta(da6:te c xfer 0
> Jun 7 15:13:50 s18 kernel: mpr0:0: (xpt0:mpr0:0:16:0): SMID 1 abort
> TaskMID 1016 status 0x0 code 0x0 count 5
> Jun 7 15:13:50 s18 kernel: 16: (xpt0:mpr0:0:16:0): SMID 1 finished
> recovery after aborting TaskMID 1016
> Jun 7 15:13:50 s18 kernel: 0): mpr0: Retrying command
> Jun 7 15:13:50 s18 kernel: Unfreezing devq for target ID 16
> Jun 7 15:13:50 s18 kernel: mpr0: EventReply :
> Jun 7 15:13:50 s18 kernel: EventDataLength: 4
> Jun 7 15:13:50 s18 kernel: AckRequired: 0
> Jun 7 15:13:50 s18 kernel: Event: SasTopologyChangeList (0x1c)
> Jun 7 15:13:50 s18 kernel: EventContext: 0x0
> Jun 7 15:13:50 s18 kernel: EnclosureHandle: 0x2
> Jun 7 15:13:50 s18 kernel: ExpanderDevHandle: 0x9
> Jun 7 15:13:50 s18 kernel: NumPhys: 31
> Jun 7 15:13:50 s18 kernel: NumEntries: 1
> Jun 7 15:13:50 s18 kernel: StartPhyNum: 8
> Jun 7 15:13:50 s18 kernel: ExpStatus: Responding (0x3)
> Jun 7 15:13:50 s18 kernel: PhysicalPort: 0
> Jun 7 15:13:50 s18 kernel: PHY[8].AttachedDevHandle: 0x0010
> Jun 7 15:13:50 s18 kernel: PHY[8].LinkRate: 12.0Gbps (0xbb)
> Jun 7 15:13:50 s18 kernel: PHY[8].PhyStatus: PHYLinkStatusChange
> Jun 7 15:13:50 s18 kernel: mpr0: (0)->(mprsas_fw_work) Working on
> Event: [16]
> Jun 7 15:13:50 s18 kernel: mpr0: (1)->(mprsas_fw_work) Event Free: [16]
> Jun 7 15:13:50 s18 kernel: mpr0: (1)->(mprsas_fw_work) Working on
> Event: [1c]
> Jun 7 15:13:50 s18 kernel: mpr0: (2)->(mprsas_fw_work) Event Free: [1c]
> Jun 7 15:13:50 s18 kernel: mpr0: EventReply :
> Jun 7 15:13:50 s18 kernel: EventDataLength: 2
> Jun 7 15:13:50 s18 kernel: AckRequired: 0
> Jun 7 15:13:50 s18 kernel: Event: SasDiscovery (0x16)
> Jun 7 15:13:50 s18 kernel: EventContext: 0x0
> Jun 7 15:13:50 s18 kernel: Flags: 0
> Jun 7 15:13:50 s18 kernel: ReasonCode: Discovery Complete
> Jun 7 15:13:50 s18 kernel: PhysicalPort: 0
> Jun 7 15:13:50 s18 kernel: DiscoveryStatus: 0
> Jun 7 15:13:50 s18 kernel: mpr0: (2)->(mprsas_fw_work) Working on
> Event: [16]
> Jun 7 15:13:50 s18 kernel: mpr0: (3)->(mprsas_fw_work) Event Free: [16]
> Jun 7 15:13:51 s18 kernel: (da6:mpr0:0:16:0): SYNCHRONIZE CACHE(10).
> CDB: 35 00 00 00 00 00 00 00 00 00
> Jun 7 15:13:51 s18 kernel: (da6:mpr0:0:16:0): CAM status: SCSI Status
> Error
> Jun 7 15:13:51 s18 kernel: (da6:mpr0:0:16:0): SCSI status: Check
> Condition
> Jun 7 15:13:51 s18 kernel: (da6:mpr0:0:16:0): SCSI sense: UNIT
> ATTENTION asc:29,0 (Power on, reset, or bus device reset occurred)
> Jun 7 15:13:51 s18 kernel: (da6:mpr0:0:16:0): Retrying command (per
> sense data)
>
> -Kyle
>
> On 6/7/16 2:53 PM, Steven Hartland wrote:
>> CDB: 85 is a TRIM command IIRC, I know you tried it before using BIO
>> delete but assuming your running ZFS can you set the following in
>> loader.conf and see how you get on.
>> vfs.zfs.trim.enabled=0
>>
>> Regards
>> Steve
>
>
> _______________________________________________
> freebsd-scsi at freebsd.org mailing list
> https://lists.freebsd.org/mailman/listinfo/freebsd-scsi
> To unsubscribe, send any mail to "freebsd-scsi-unsubscribe at freebsd.org"
More information about the freebsd-scsi
mailing list