* [Bug 20712] New: mpt2sas and SATA drives
@ 2010-10-18 19:37 bugzilla-daemon
2010-10-18 19:50 ` [Bug 20712] " bugzilla-daemon
` (2 more replies)
0 siblings, 3 replies; 4+ messages in thread
From: bugzilla-daemon @ 2010-10-18 19:37 UTC (permalink / raw)
To: linux-scsi
https://bugzilla.kernel.org/show_bug.cgi?id=20712
Summary: mpt2sas and SATA drives
Product: SCSI Drivers
Version: 2.5
Kernel Version: 2.6.34.7-56.fc13.x86_64
Platform: All
OS/Version: Linux
Tree: Fedora
Status: NEW
Severity: normal
Priority: P1
Component: Other
AssignedTo: scsi_drivers-other@kernel-bugs.osdl.org
ReportedBy: zeuthen@gmail.com
Regression: No
Occasionally /lib/udev/ata_id fails with EINVAL (see details below) and this
causes missing symlinks in the /dev/disk/ hierarchies. Surely this is a problem
with the driver right - e.g. ata_id is not supposed to retry.
For reference ata_id is located here
http://git.kernel.org/?p=linux/hotplug/udev.git;a=blob;f=extras/ata_id/ata_id.c;h=bf1debe028e97228e09d4bd5bfdd280bb32099f3;hb=HEAD
I'm seeing this with the mpt2sas driver in Fedora 13's 2.6.34.7-56.fc13.x86_64
mpt2sas driver. Details here:
Here's the script I use to reproduce it
# cat hammer-ata.sh
#!/bin/bash
set -e
ATA_ID=/lib/udev/ata_id
while true ; do
echo "----------------------------------------------------------------"
strace -o /tmp/ata_id_out.txt $ATA_ID --export /dev/sdp
sleep 0.1
done
When /lib/udev/ata_id fails, the strace is
execve("/lib/udev/ata_id", ["/lib/udev/ata_id", "--export", "/dev/sdp"], [/*
19 vars */]) = 0
brk(0) = 0x1cd9000
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x7f83e02e7000
access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file or
directory)
open("/etc/ld.so.cache", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=70476, ...}) = 0
mmap(NULL, 70476, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7f83e02d5000
close(3) = 0
open("/lib64/libc.so.6", O_RDONLY) = 3
read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0p\355a\3637\0\0\0"...,
832) = 832
fstat(3, {st_mode=S_IFREG|0755, st_size=1838304, ...}) = 0
mmap(0x37f3600000, 3664040, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3,
0) = 0x37f3600000
mprotect(0x37f3775000, 2097152, PROT_NONE) = 0
mmap(0x37f3975000, 20480, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x175000) = 0x37f3975000
mmap(0x37f397a000, 18600, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x37f397a000
close(3) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x7f83e02d4000
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x7f83e02d3000
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x7f83e02d2000
arch_prctl(ARCH_SET_FS, 0x7f83e02d3700) = 0
mprotect(0x37f3975000, 16384, PROT_READ) = 0
mprotect(0x37f341e000, 4096, PROT_READ) = 0
munmap(0x7f83e02d5000, 70476) = 0
brk(0) = 0x1cd9000
brk(0x1cfa000) = 0x1cfa000
open("/etc/udev/udev.conf", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=218, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x7f83e02e6000
read(3, "# The initial syslog(3) priority"..., 4096) = 218
read(3, "", 4096) = 0
close(3) = 0
munmap(0x7f83e02e6000, 4096) = 0
open("/dev/sdp", O_RDONLY|O_NONBLOCK) = 3
fstat(3, {st_mode=S_IFBLK|0660, st_rdev=makedev(8, 240), ...}) = 0
ioctl(3, CDROM_GET_CAPABILITY, 0) = -1 EINVAL (Invalid argument)
ioctl(3, BLKGETSIZE64, 0x7fffe8b83e38) = 0
ioctl(3, SG_IO, {'S', SG_DXFER_FROM_DEV, cmd[12]=[a1, 08, 2e, 00, 01, 00, 00,
00, 00, ec, 00, 00], mx_sb_len=32, iovec_count=0, dxfer_len=512, timeout=2000,
flags=0, data[512]=["zB\377?7\310\20\0\0\0\0\0?\0\0\0\0\0\0\0 W -DCWWA"...],
status=00, masked_status=00, sb[0]=[], host_status=0x8, driver_status=0,
resid=0, duration=1122, info=0x1}) = 0
ioctl(3, 0x30d, 0x7fffe8b84040) = -1 EINVAL (Invalid argument)
open("/etc/localtime", O_RDONLY) = 4
fstat(4, {st_mode=S_IFREG|0644, st_size=3519, ...}) = 0
fstat(4, {st_mode=S_IFREG|0644, st_size=3519, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x7f83e02e6000
read(4, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\4\0\0\0\4\0\0\0\0"...,
4096) = 3519
lseek(4, -2252, SEEK_CUR) = 1267
read(4, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\5\0\0\0\5\0\0\0\0"...,
4096) = 2252
close(4) = 0
munmap(0x7f83e02e6000, 4096) = 0
getpid() = 8026
socket(PF_FILE, SOCK_DGRAM|SOCK_CLOEXEC, 0) = 4
connect(4, {sa_family=AF_FILE, path="/dev/log"}, 110) = 0
sendto(4, "<27>Oct 18 15:25:55 ata_id[8026]"..., 74, MSG_NOSIGNAL, NULL, 0) =
74
close(3) = 0
close(4) = 0
exit_group(3)
strace from a "healthy" run of ata_id is:
# strace -o ata_id_out_works.txt /lib/udev/ata_id --export /dev/sdp
ID_ATA=1
ID_TYPE=disk
ID_BUS=ata
ID_MODEL=WDC_WD1002FAEX-00Y9A0
ID_MODEL_ENC=WDC\x20WD1002FAEX-00Y9A0\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20
ID_REVISION=01.01V10
ID_SERIAL=WDC_WD1002FAEX-00Y9A0_WD-WCAW30039741
ID_SERIAL_SHORT=WD-WCAW30039741
ID_ATA_WRITE_CACHE=1
ID_ATA_WRITE_CACHE_ENABLED=1
ID_ATA_FEATURE_SET_HPA=1
ID_ATA_FEATURE_SET_HPA_ENABLED=1
ID_ATA_FEATURE_SET_PM=1
ID_ATA_FEATURE_SET_PM_ENABLED=1
ID_ATA_FEATURE_SET_SECURITY=1
ID_ATA_FEATURE_SET_SECURITY_ENABLED=0
ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN=162
ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN=162
ID_ATA_FEATURE_SET_SMART=1
ID_ATA_FEATURE_SET_SMART_ENABLED=1
ID_ATA_FEATURE_SET_AAM=1
ID_ATA_FEATURE_SET_AAM_ENABLED=0
ID_ATA_FEATURE_SET_AAM_VENDOR_RECOMMENDED_VALUE=128
ID_ATA_FEATURE_SET_AAM_CURRENT_VALUE=254
ID_ATA_FEATURE_SET_PUIS=1
ID_ATA_FEATURE_SET_PUIS_ENABLED=0
ID_ATA_DOWNLOAD_MICROCODE=1
ID_ATA_SATA=1
ID_ATA_SATA_SIGNAL_RATE_GEN2=1
ID_ATA_SATA_SIGNAL_RATE_GEN1=1
ID_WWN=0x50014ee2af4e8611
ID_WWN_WITH_EXTENSION=0x50014ee2af4e8611
execve("/lib/udev/ata_id", ["/lib/udev/ata_id", "--export", "/dev/sdp"], [/*
20 vars */]) = 0
brk(0) = 0x1120000
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x7ff7ae236000
access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file or
directory)
open("/etc/ld.so.cache", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=70476, ...}) = 0
mmap(NULL, 70476, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7ff7ae224000
close(3) = 0
open("/lib64/libc.so.6", O_RDONLY) = 3
read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0p\355a\3637\0\0\0"...,
832) = 832
fstat(3, {st_mode=S_IFREG|0755, st_size=1838304, ...}) = 0
mmap(0x37f3600000, 3664040, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3,
0) = 0x37f3600000
mprotect(0x37f3775000, 2097152, PROT_NONE) = 0
mmap(0x37f3975000, 20480, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x175000) = 0x37f3975000
mmap(0x37f397a000, 18600, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x37f397a000
close(3) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x7ff7ae223000
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x7ff7ae222000
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x7ff7ae221000
arch_prctl(ARCH_SET_FS, 0x7ff7ae222700) = 0
mprotect(0x37f3975000, 16384, PROT_READ) = 0
mprotect(0x37f341e000, 4096, PROT_READ) = 0
munmap(0x7ff7ae224000, 70476) = 0
brk(0) = 0x1120000
brk(0x1141000) = 0x1141000
open("/etc/udev/udev.conf", O_RDONLY) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=218, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x7ff7ae235000
read(3, "# The initial syslog(3) priority"..., 4096) = 218
read(3, "", 4096) = 0
close(3) = 0
munmap(0x7ff7ae235000, 4096) = 0
open("/dev/sdp", O_RDONLY|O_NONBLOCK) = 3
fstat(3, {st_mode=S_IFBLK|0660, st_rdev=makedev(8, 240), ...}) = 0
ioctl(3, CDROM_GET_CAPABILITY, 0) = -1 EINVAL (Invalid argument)
ioctl(3, BLKGETSIZE64, 0x7fff1f8306f8) = 0
ioctl(3, SG_IO, {'S', SG_DXFER_FROM_DEV, cmd[12]=[a1, 08, 2e, 00, 01, 00, 00,
00, 00, ec, 00, 00], mx_sb_len=32, iovec_count=0, dxfer_len=512, timeout=2000,
flags=0, data[512]=["zB\377?7\310\20\0\0\0\0\0?\0\0\0\0\0\0\0 W -DCWWA"...],
status=02, masked_status=01, sb[22]=[72, 01, 00, 1d, 00, 00, 00, 0e, 09, 0c,
00, 00, 00, 00, 00, 00, 00, 00, 00, 00, 00, 00], host_status=0,
driver_status=0x8, resid=0, duration=248, info=0x1}) = 0
fstat(1, {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 0), ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x7ff7ae235000
write(1, "ID_ATA=1\n", 9) = 9
write(1, "ID_TYPE=disk\n", 13) = 13
write(1, "ID_BUS=ata\n", 11) = 11
write(1, "ID_MODEL=WDC_WD1002FAEX-00Y9A0\n", 31) = 31
write(1, "ID_MODEL_ENC=WDC\\x20WD1002FAEX-0"..., 114) = 114
write(1, "ID_REVISION=01.01V10\n", 21) = 21
write(1, "ID_SERIAL=WDC_WD1002FAEX-00Y9A0_"..., 48) = 48
write(1, "ID_SERIAL_SHORT=WD-WCAW30039741\n", 32) = 32
write(1, "ID_ATA_WRITE_CACHE=1\n", 21) = 21
write(1, "ID_ATA_WRITE_CACHE_ENABLED=1\n", 29) = 29
write(1, "ID_ATA_FEATURE_SET_HPA=1\n", 25) = 25
write(1, "ID_ATA_FEATURE_SET_HPA_ENABLED=1"..., 33) = 33
write(1, "ID_ATA_FEATURE_SET_PM=1\n", 24) = 24
write(1, "ID_ATA_FEATURE_SET_PM_ENABLED=1\n", 32) = 32
write(1, "ID_ATA_FEATURE_SET_SECURITY=1\n", 30) = 30
write(1, "ID_ATA_FEATURE_SET_SECURITY_ENAB"..., 38) = 38
write(1, "ID_ATA_FEATURE_SET_SECURITY_ERAS"..., 47) = 47
write(1, "ID_ATA_FEATURE_SET_SECURITY_ENHA"..., 56) = 56
write(1, "ID_ATA_FEATURE_SET_SMART=1\n", 27) = 27
write(1, "ID_ATA_FEATURE_SET_SMART_ENABLED"..., 35) = 35
write(1, "ID_ATA_FEATURE_SET_AAM=1\n", 25) = 25
write(1, "ID_ATA_FEATURE_SET_AAM_ENABLED=0"..., 33) = 33
write(1, "ID_ATA_FEATURE_SET_AAM_VENDOR_RE"..., 52) = 52
write(1, "ID_ATA_FEATURE_SET_AAM_CURRENT_V"..., 41) = 41
write(1, "ID_ATA_FEATURE_SET_PUIS=1\n", 26) = 26
write(1, "ID_ATA_FEATURE_SET_PUIS_ENABLED="..., 34) = 34
write(1, "ID_ATA_DOWNLOAD_MICROCODE=1\n", 28) = 28
write(1, "ID_ATA_SATA=1\n", 14) = 14
write(1, "ID_ATA_SATA_SIGNAL_RATE_GEN2=1\n", 31) = 31
write(1, "ID_ATA_SATA_SIGNAL_RATE_GEN1=1\n", 31) = 31
write(1, "ID_WWN=0x50014ee2af4e8611\n", 26) = 26
write(1, "ID_WWN_WITH_EXTENSION=0x50014ee2"..., 41) = 41
close(3) = 0
exit_group(0) = ?
The kernel messages when seeing the failure is:
Oct 18 15:25:54 rhea kernel: DRHD: handling fault status reg 502
Oct 18 15:25:54 rhea kernel: DMAR:[DMA Read] Request device [0a:00.0] fault
addr 2e0000
Oct 18 15:25:54 rhea kernel: DMAR:[fault reason 06] PTE Read access is not set
Oct 18 15:25:54 rhea kernel: mpt2sas0: fault_state(0x2665)!
Oct 18 15:25:54 rhea kernel: mpt2sas0: sending diag reset !!
Oct 18 15:25:55 rhea kernel: mpt2sas0: diag reset: SUCCESS
Oct 18 15:25:55 rhea ata_id[8026]: HDIO_GET_IDENTITY failed for '/dev/sdp'
Oct 18 15:25:55 rhea kernel: mpt2sas0: LSISAS2116: FWVersion(03.00.00.00),
ChipRevision(0x01), BiosVersion(07.01.00.00)
Oct 18 15:25:55 rhea kernel: mpt2sas0: Protocol=(Initiator,Target),
Capabilities=(TLR,EEDP,Snapshot Buffer,Diag Trace Buffer,Task Set Full,NCQ)
Oct 18 15:25:55 rhea kernel: mpt2sas0: sending port enable !!
Oct 18 15:26:04 rhea kernel: mpt2sas0: port enable: SUCCESS
Oct 18 15:26:04 rhea kernel: mpt2sas0: _scsih_search_responding_sas_devices
Oct 18 15:26:04 rhea kernel: scsi target0:0:0: handle(0x0012),
sas_addr(0x5000c50023bfb29a), enclosure logical id(0x5000155350e0133f), slot(0)
Oct 18 15:26:04 rhea kernel: scsi target0:0:1: handle(0x0013),
sas_addr(0x5000c50023c075d6), enclosure logical id(0x5000155350e0133f), slot(1)
Oct 18 15:26:04 rhea kernel: scsi target0:0:2: handle(0x0014),
sas_addr(0x5000c50023bad29e), enclosure logical id(0x5000155350e0133f), slot(2)
Oct 18 15:26:04 rhea kernel: scsi target0:0:3: handle(0x0015),
sas_addr(0x5000c50023c08492), enclosure logical id(0x5000155350e0133f), slot(3)
Oct 18 15:26:04 rhea kernel: scsi target0:0:4: handle(0x0016),
sas_addr(0x5000c50023bdbb7a), enclosure logical id(0x5000155350e0133f), slot(4)
Oct 18 15:26:04 rhea kernel: scsi target0:0:5: handle(0x0017),
sas_addr(0x5000c50023be7d72), enclosure logical id(0x5000155350e0133f), slot(5)
Oct 18 15:26:04 rhea kernel: scsi target0:0:6: handle(0x0018),
sas_addr(0x5000c50023bf9fbe), enclosure logical id(0x5000155350e0133f), slot(6)
Oct 18 15:26:04 rhea kernel: scsi target0:0:7: handle(0x0019),
sas_addr(0x5000c50023c1118e), enclosure logical id(0x5000155350e0133f), slot(7)
Oct 18 15:26:04 rhea kernel: scsi target0:0:8: handle(0x001a),
sas_addr(0x5000c50023bd83e6), enclosure logical id(0x5000155350e0133f), slot(8)
Oct 18 15:26:04 rhea kernel: scsi target0:0:9: handle(0x001b),
sas_addr(0x5000c50023bcdb6a), enclosure logical id(0x5000155350e0133f), slot(9)
Oct 18 15:26:04 rhea kernel: scsi target0:0:10: handle(0x001c),
sas_addr(0x5000c50023bddd9a), enclosure logical id(0x5000155350e0133f),
slot(10)
Oct 18 15:26:04 rhea kernel: scsi target0:0:11: handle(0x001d),
sas_addr(0x5000c50023c0c4f2), enclosure logical id(0x5000155350e0133f),
slot(11)
Oct 18 15:26:04 rhea kernel: scsi target0:0:12: handle(0x001e),
sas_addr(0x5000155350e0133e), enclosure logical id(0x5000155350e0133f),
slot(24)
Oct 18 15:26:04 rhea kernel: scsi target0:0:30: handle(0x0021),
sas_addr(0x5000c50023bfb299), enclosure logical id(0x5000155350e0123f), slot(0)
Oct 18 15:26:04 rhea kernel: handle changed from(0x0029)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:13: handle(0x0022),
sas_addr(0x500015560011d200), enclosure logical id(0x500015560011d23f), slot(0)
Oct 18 15:26:04 rhea kernel: handle changed from(0x0021)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:14: handle(0x0023),
sas_addr(0x500015560011d201), enclosure logical id(0x500015560011d23f), slot(1)
Oct 18 15:26:04 rhea kernel: handle changed from(0x0022)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:15: handle(0x0024),
sas_addr(0x500015560011d202), enclosure logical id(0x500015560011d23f), slot(2)
Oct 18 15:26:04 rhea kernel: handle changed from(0x0023)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:16: handle(0x0025),
sas_addr(0x500015560011d203), enclosure logical id(0x500015560011d23f), slot(3)
Oct 18 15:26:04 rhea kernel: handle changed from(0x0024)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:17: handle(0x0026),
sas_addr(0x500015560011d204), enclosure logical id(0x500015560011d23f), slot(4)
Oct 18 15:26:04 rhea kernel: handle changed from(0x0025)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:18: handle(0x0027),
sas_addr(0x500015560011d205), enclosure logical id(0x500015560011d23f), slot(5)
Oct 18 15:26:04 rhea kernel: handle changed from(0x0026)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:19: handle(0x0028),
sas_addr(0x500015560011d206), enclosure logical id(0x500015560011d23f), slot(6)
Oct 18 15:26:04 rhea kernel: handle changed from(0x0027)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:20: handle(0x0029),
sas_addr(0x500015560011d207), enclosure logical id(0x500015560011d23f), slot(7)
Oct 18 15:26:04 rhea kernel: handle changed from(0x0028)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:31: handle(0x002a),
sas_addr(0x5000c50023c075d5), enclosure logical id(0x5000155350e0123f), slot(1)
Oct 18 15:26:04 rhea kernel: handle changed from(0x0032)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:21: handle(0x002b),
sas_addr(0x500015560011d208), enclosure logical id(0x500015560011d23f), slot(8)
Oct 18 15:26:04 rhea kernel: handle changed from(0x002a)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:22: handle(0x002c),
sas_addr(0x500015560011d209), enclosure logical id(0x500015560011d23f), slot(9)
Oct 18 15:26:04 rhea kernel: handle changed from(0x002b)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:23: handle(0x002d),
sas_addr(0x500015560011d20a), enclosure logical id(0x500015560011d23f),
slot(10)
Oct 18 15:26:04 rhea kernel: handle changed from(0x002c)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:24: handle(0x002e),
sas_addr(0x500015560011d20b), enclosure logical id(0x500015560011d23f),
slot(11)
Oct 18 15:26:04 rhea kernel: handle changed from(0x002d)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:25: handle(0x002f),
sas_addr(0x500015560011d20c), enclosure logical id(0x500015560011d23f),
slot(12)
Oct 18 15:26:04 rhea kernel: handle changed from(0x002e)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:26: handle(0x0030),
sas_addr(0x500015560011d20d), enclosure logical id(0x500015560011d23f),
slot(13)
Oct 18 15:26:04 rhea kernel: handle changed from(0x002f)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:27: handle(0x0031),
sas_addr(0x500015560011d20e), enclosure logical id(0x500015560011d23f),
slot(14)
Oct 18 15:26:04 rhea kernel: handle changed from(0x0030)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:28: handle(0x0032),
sas_addr(0x500015560011d20f), enclosure logical id(0x500015560011d23f),
slot(15)
Oct 18 15:26:04 rhea kernel: handle changed from(0x0031)!!!
Oct 18 15:26:04 rhea kernel: scsi target0:0:32: handle(0x0033),
sas_addr(0x5000c50023bad29d), enclosure logical id(0x5000155350e0123f), slot(2)
Oct 18 15:26:04 rhea kernel: scsi target0:0:33: handle(0x0034),
sas_addr(0x5000c50023c08491), enclosure logical id(0x5000155350e0123f), slot(3)
Oct 18 15:26:04 rhea kernel: scsi target0:0:29: handle(0x0035),
sas_addr(0x500015560011d23e), enclosure logical id(0x500015560011d23f),
slot(36)
Oct 18 15:26:04 rhea kernel: scsi target0:0:34: handle(0x0036),
sas_addr(0x5000c50023bdbb79), enclosure logical id(0x5000155350e0123f), slot(4)
Oct 18 15:26:04 rhea kernel: scsi target0:0:35: handle(0x0037),
sas_addr(0x5000c50023be7d71), enclosure logical id(0x5000155350e0123f), slot(5)
Oct 18 15:26:04 rhea kernel: scsi target0:0:36: handle(0x0038),
sas_addr(0x5000c50023bf9fbd), enclosure logical id(0x5000155350e0123f), slot(6)
Oct 18 15:26:04 rhea kernel: scsi target0:0:37: handle(0x0039),
sas_addr(0x5000c50023c1118d), enclosure logical id(0x5000155350e0123f), slot(7)
Oct 18 15:26:04 rhea kernel: scsi target0:0:38: handle(0x003a),
sas_addr(0x5000c50023bd83e5), enclosure logical id(0x5000155350e0123f), slot(8)
Oct 18 15:26:04 rhea kernel: scsi target0:0:39: handle(0x003b),
sas_addr(0x5000c50023bcdb69), enclosure logical id(0x5000155350e0123f), slot(9)
Oct 18 15:26:04 rhea kernel: scsi target0:0:40: handle(0x003c),
sas_addr(0x5000c50023bddd99), enclosure logical id(0x5000155350e0123f),
slot(10)
Oct 18 15:26:04 rhea kernel: scsi target0:0:41: handle(0x003d),
sas_addr(0x5000c50023c0c4f1), enclosure logical id(0x5000155350e0123f),
slot(11)
Oct 18 15:26:04 rhea kernel: scsi target0:0:42: handle(0x003e),
sas_addr(0x5000155350e0123e), enclosure logical id(0x5000155350e0123f),
slot(24)
Oct 18 15:26:04 rhea kernel: mpt2sas0: _scsih_search_responding_raid_devices
Oct 18 15:26:04 rhea kernel: mpt2sas0: _scsih_search_responding_expanders
Oct 18 15:26:04 rhea kernel: expander present: handle(0x0011),
sas_addr(0x5000155350e0133f)
Oct 18 15:26:04 rhea kernel: expander present: handle(0x001f),
sas_addr(0x5000155350e0123f)
Oct 18 15:26:04 rhea kernel: expander present: handle(0x0020),
sas_addr(0x500015560011d23f)
Oct 18 15:26:04 rhea kernel: mpt2sas0: _base_fault_reset_work: hard reset:
success
--
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are watching the assignee of the bug.
^ permalink raw reply [flat|nested] 4+ messages in thread* [Bug 20712] mpt2sas and SATA drives
2010-10-18 19:37 [Bug 20712] New: mpt2sas and SATA drives bugzilla-daemon
@ 2010-10-18 19:50 ` bugzilla-daemon
2010-10-18 19:58 ` bugzilla-daemon
2010-10-19 18:21 ` bugzilla-daemon
2 siblings, 0 replies; 4+ messages in thread
From: bugzilla-daemon @ 2010-10-18 19:50 UTC (permalink / raw)
To: linux-scsi
https://bugzilla.kernel.org/show_bug.cgi?id=20712
--- Comment #1 from David Zeuthen <zeuthen@gmail.com> 2010-10-18 19:50:25 ---
(In reply to comment #0)
> Occasionally /lib/udev/ata_id fails with EINVAL (see details below)
Actually I read it wrong. It's the SG_DXFER_FROM_DEV ioctl that is causing the
problem. Here's the strace output from a failed run
ioctl(3, SG_IO, {'S', SG_DXFER_FROM_DEV,
cmd[12]=[a1, 08, 2e, 00, 01, 00, 00, 00, 00, ec, 00, 00],
mx_sb_len=32,
iovec_count=0,
dxfer_len=512,
timeout=2000,
flags=0,
data[512]=["\x7a\x42\xff\x3f\x37\xc8\x10\x00\x00\x00\x00\x00\x3f
\x00\x00\x00\x00\x00\x00\x00\x20\x20\x20\x20\x57\x20\x2d\x44\x43
\x57\x57\x41\x30\x33\x33\x30\x37\x39\x31\x34\x00\x00\x00\x00\x32
\x00\x31\x30\x30\x2e\x56\x31\x31\x30\x44\x57\x20\x43\x44\x57\x30
\x31\x32\x30\x41\x46\x58\x45\x30\x2d\x59\x30\x41\x39\x20\x30\x20
\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20
\x20\x10\x80\x00\x00\x00\x2f\x01\x40\x00\x00\x00\x00\x07\x00\xff
\x3f\x10\x00\x3f\x00\x10\xfc\xfb\x00\x00\x01\xff\xff\xff\x0f\x00
\x00\x07\x00\x03\x00\x78\x00\x78\x00\x78\x00\x78\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x1f\x00\x06\x17\x00\x00\x44
\x00\x40\x00\xfe\x01\x00\x00\x6b\x74\x61\x77\x23\x41\x69\x74\x41
\xb4\x23\x41\x7f\x40\x51\x00\x51\x00\x00\x00\xfe\xff\x00\x00\xfe
\x80\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\xb0\x6d\x70\x74\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x01\x50\xe2\x4e\x4e
\xaf\x11\x86\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x18\x40\x18\x40\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x21\x00\x00\x00\x00\x00\x00\x00\x00\x00\xfe\x16\xe6
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x04
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00"],
status=00, masked_status=00, sb[0]=[],
host_status=0x8, driver_status=0, resid=0, duration=1378, info=0x1}) = 0
and here it is from a successful run
ioctl(3, SG_IO, {'S', SG_DXFER_FROM_DEV,
cmd[12]=[a1, 08, 2e, 00, 01, 00, 00, 00, 00, ec, 00, 00],
mx_sb_len=32,
iovec_count=0,
dxfer_len=512,
timeout=2000,
flags=0,
data[512]=["\x7a\x42\xff\x3f\x37\xc8\x10\x00\x00\x00\x00\x00\x3f
\x00\x00\x00\x00\x00\x00\x00\x20\x20\x20\x20\x57\x20\x2d\x44\x43
\x57\x57\x41\x30\x33\x33\x30\x37\x39\x31\x34\x00\x00\x00\x00\x32
\x00\x31\x30\x30\x2e\x56\x31\x31\x30\x44\x57\x20\x43\x44\x57\x30
\x31\x32\x30\x41\x46\x58\x45\x30\x2d\x59\x30\x41\x39\x20\x30\x20
\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20\x20
\x20\x10\x80\x00\x00\x00\x2f\x01\x40\x00\x00\x00\x00\x07\x00\xff
\x3f\x10\x00\x3f\x00\x10\xfc\xfb\x00\x00\x01\xff\xff\xff\x0f\x00
\x00\x07\x00\x03\x00\x78\x00\x78\x00\x78\x00\x78\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x1f\x00\x06\x17\x00\x00\x44
\x00\x40\x00\xfe\x01\x00\x00\x6b\x74\x61\x77\x23\x41\x69\x74\x41
\xb4\x23\x41\x7f\x40\x51\x00\x51\x00\x00\x00\xfe\xff\x00\x00\xfe
\x80\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\xb0\x6d\x70\x74\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x01\x50\xe2\x4e\x4e
\xaf\x11\x86\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x18\x40\x18\x40\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x21\x00\x00\x00\x00\x00\x00\x00\x00\x00\xfe\x16\xe6
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x04
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x35
\x30\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x1e
\x10\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x01\x00\x00\x10\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\xa5\x8e"],
status=02, masked_status=01,
sb[22]=[72, 01, 00, 1d, 00, 00, 00, 0e, 09, 0c, 00, 00, 00, 00, 00, 00, 00, 00,
00, 00, 00, 00],
host_status=0, driver_status=0x8, resid=0, duration=142, info=0x1}) = 0
and here's the diff
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
+\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x35
+\x30\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
+\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x1e
+\x10\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
+\x00\x00\x00\x00\x00\x00\x00\x01\x00\x00\x10\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
-\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
-\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
-\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
-\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
-\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00
-\x00\x00\x00"],
-status=00, masked_status=00, sb[0]=[],
-host_status=0x8, driver_status=0, resid=0, duration=1378, info=0x1}) = 0
+\x00\xa5\x8e"],
+status=02, masked_status=01,
+sb[22]=[72, 01, 00, 1d, 00, 00, 00, 0e, 09, 0c, 00, 00, 00, 00, 00, 00, 00,
00, 00, 00, 00, 00],
+host_status=0, driver_status=0x8, resid=0, duration=142, info=0x1}) = 0
--
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are watching the assignee of the bug.
^ permalink raw reply [flat|nested] 4+ messages in thread* [Bug 20712] mpt2sas and SATA drives
2010-10-18 19:37 [Bug 20712] New: mpt2sas and SATA drives bugzilla-daemon
2010-10-18 19:50 ` [Bug 20712] " bugzilla-daemon
@ 2010-10-18 19:58 ` bugzilla-daemon
2010-10-19 18:21 ` bugzilla-daemon
2 siblings, 0 replies; 4+ messages in thread
From: bugzilla-daemon @ 2010-10-18 19:58 UTC (permalink / raw)
To: linux-scsi
https://bugzilla.kernel.org/show_bug.cgi?id=20712
--- Comment #2 from David Zeuthen <zeuthen@gmail.com> 2010-10-18 19:58:19 ---
(In reply to comment #1)
> timeout=2000,
Btw, bumping the timeout doesn't fix the problem (bumping the timeout from
2000ms would probably be a good idea regardless). We could retry sending the
command.. but my understanding is that we shouldn't have to do this, right?
Thanks for any insight.
--
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are watching the assignee of the bug.
^ permalink raw reply [flat|nested] 4+ messages in thread
* [Bug 20712] mpt2sas and SATA drives
2010-10-18 19:37 [Bug 20712] New: mpt2sas and SATA drives bugzilla-daemon
2010-10-18 19:50 ` [Bug 20712] " bugzilla-daemon
2010-10-18 19:58 ` bugzilla-daemon
@ 2010-10-19 18:21 ` bugzilla-daemon
2 siblings, 0 replies; 4+ messages in thread
From: bugzilla-daemon @ 2010-10-19 18:21 UTC (permalink / raw)
To: linux-scsi
https://bugzilla.kernel.org/show_bug.cgi?id=20712
David Zeuthen <zeuthen@gmail.com> changed:
What |Removed |Added
----------------------------------------------------------------------------
Status|NEW |RESOLVED
Resolution| |OBSOLETE
--- Comment #3 from David Zeuthen <zeuthen@gmail.com> 2010-10-19 18:21:11 ---
(In reply to comment #2)
> Oct 18 15:25:55 rhea kernel: mpt2sas0: LSISAS2116: FWVersion(03.00.00.00),
ChipRevision(0x01), BiosVersion(07.01.00.00)
OK, inspired by James' reply here
http://www.spinics.net/lists/linux-scsi/msg42367.html
specifically
So this is likely a firmware bug inside the mpt2sas. All of the mpt
cards use a fat firmware model meaning they take in pure SCSI commands
and do the translation to SATA if necessary all within the firmware, so
the first step would be to make sure your card has the latest firmware.
I've updated the card to the latest firmware
Oct 19 14:11:45 rhea kernel: mpt2sas0: LSISAS2116: FWVersion(07.00.00.00),
ChipRevision(0x01), BiosVersion(07.01.00.00)
e.g. from version 03.00.00.00 to version 07.00.00.00 and suddenly all the
problems go away. So I'm closing this bug.
(And I also note that there's a lot of low-hanging fruit here - we really
should make it easy for users to a) know that there is a firmware update; b)
make it easy update the firmware... could maybe do this in the
udisks/palimpsest stack -maybe start by just support a couple of vendors. I
don't know.)
--
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are watching the assignee of the bug.
^ permalink raw reply [flat|nested] 4+ messages in thread
end of thread, other threads:[~2010-10-19 18:21 UTC | newest]
Thread overview: 4+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2010-10-18 19:37 [Bug 20712] New: mpt2sas and SATA drives bugzilla-daemon
2010-10-18 19:50 ` [Bug 20712] " bugzilla-daemon
2010-10-18 19:58 ` bugzilla-daemon
2010-10-19 18:21 ` bugzilla-daemon
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).