Skip to contentSkip to conversation

New: exception & eSATA hard link resets

Bug 30802 [email protected] 1 participant 9 messages Mar 9, 2011 – Jul 2, 2012 libata

lore
Share & tools
lore

[email protected]

author
#0 lore raw

https://bugzilla.kernel.org/show_bug.cgi?id=30802

Summary: exception & eSATA hard link resets
Product: IO/Storage
Version: 2.5
Kernel Version: 2.6.37.2
Platform: All
OS/Version: Linux
Tree: Mainline
Status: NEW
Severity: blocking
Priority: P1
Component: Serial ATA
AssignedTo: [email protected]
ReportedBy: [email protected]
CC: [email protected]
Regression: No

Created an attachment (id=50442)
--> (https://bugzilla.kernel.org/attachment.cgi?id=50442)
kernel log, dmesg and lspci output

Hi,
using eSATA on Thinkpad W510 does not work for me (tested with kernel 2.6.35 on). At the beginning I've suspected VirtualBox problems (usage of virtualization features of i7), but today hard reset has occurred even before Virtualbox has been started.

The reset happens very often ("exception Emask 0x10 SAct 0x0 SErr 0x4050000 action 0xe frozen" is caught) - almost for sure in an hour and repeats till connection drops.
Details from kernel.log are attached (disk has been switched off in this case - after few resets).

Files system used on all media is XFS.

[4.] Kernel information
[4.1.] Kernel version (from /proc/version):
Linux version 2.6.37.2vbox (root@think) (gcc version 4.4.5 (Ubuntu/Linaro 4.4.4-14ubuntu5) ) #1 SMP Mon Mar 7 21:14:19 CET 2011

[4.2.] Kernel .config file is attached. It was made with "make oldconfig" on Ubuntu Maverick.

[5.] Most recent kernel version which did not have the bug:
:(

[6.] Output of Oops.. message (if applicable) with symbolic information
resolved (see Documentation/oops-tracing.txt)
no Ooops... :(. Attached is the kernel log, and dmesg output

[7.] A small shell script or example program which triggers the
problem (if possible):
the easiest to reproduce is by using VirtualBox (haven't managed to try copying large files - I've planned to do this today, however connection failed before that).

[8.] Environment
[8.1.] Software (add the output of the ver_linux script here)
---
If some fields are empty or look unusual you may have an old version. Compare to the current minimal requirements in Documentation/Changes.

Linux think 2.6.37.2vbox #1 SMP Mon Mar 7 21:14:19 CET 2011 x86_64 GNU/Linux

Gnu C                  4.4.5
Gnu make               3.81
binutils               2.20.51
util-linux             2.17.2
mount                  support
module-init-tools      3.12
e2fsprogs              1.41.12
reiserfsprogs          3.6.21
xfsprogs               3.1.2
pcmciautils            014
Linux C Library        2.12.1
Dynamic linker (ldd)   2.12.1
Procps                 3.2.8
Net-tools              1.60
Kbd                    1.15
Sh-utils               8.5
wireless-tools         30
Modules Loaded         btrfs zlib_deflate crc32c libcrc32c ufs qnx4 hfsplus hfs

minix ntfs msdos jfs reiserfs usb_storage sha1_generic ppp_mppe ppp_async crc_ccitt nls_utf8 udf crc_itu_t nls_iso8859_1 nls_cp437 vfat fat binfmt_misc vboxnetadp vboxnetflt vboxdrv parport_pc ppdev nfsd nfs lockd fscache nfs_acl auth_rpcgss sunrpc snd_hda_codec_hdmi arc4 nvidia iwlagn iwlcore snd_hda_codec_conexant mac80211 snd_hda_intel xhci_hcd thinkpad_acpi snd_hda_codec tpm_tis tpm tpm_bios i7core_edac psmouse video cfg80211 edac_core lp nvram snd_hwdep snd_seq_midi snd_pcm snd_rawmidi snd_seq_midi_event shpchp serio_raw joydev snd_seq snd_timer snd_seq_device uvcvideo videodev v4l1_compat v4l2_compat_ioctl32 output snd parport soundcore snd_page_alloc xfs exportfs usbhid hid mmc_block sdhci_pci sdhci ahci e1000e libahci
---

[8.2.] Processor information (from /proc/cpuinfo):
---
processor : 0
vendor_id : GenuineIntel
cpu family : 6
model : 30
model name : Intel(R) Core(TM) i7 CPU Q 820 @ 1.73GHz
stepping : 5
cpu MHz : 1199.000
cache size : 8192 KB
physical id : 0
siblings : 8
core id : 0
cpu cores : 4
apicid : 0
initial apicid : 0
fpu : yes
fpu_exception : yes
cpuid level : 11
wp : yes
flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov
pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc aperfmperf pni dtes64 monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr pdcm sse4_1 sse4_2 popcnt lahf_lm ida dts tpr_shadow vnmi flexpriority ept vpid
bogomips : 3458.09
clflush size : 64
cache_alignment : 64
address sizes : 36 bits physical, 48 bits virtual
power management:

processor : 1
vendor_id : GenuineIntel
cpu family : 6
model : 30
model name : Intel(R) Core(TM) i7 CPU Q 820 @ 1.73GHz
stepping : 5
cpu MHz : 1199.000
cache size : 8192 KB
physical id : 0
siblings : 8
core id : 0
cpu cores : 4
apicid : 1
initial apicid : 1
fpu : yes
fpu_exception : yes
cpuid level : 11
wp : yes
flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov
pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc aperfmperf pni dtes64 monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr pdcm sse4_1 sse4_2 popcnt lahf_lm ida dts tpr_shadow vnmi flexpriority ept vpid
bogomips : 3457.94
clflush size : 64
cache_alignment : 64
address sizes : 36 bits physical, 48 bits virtual
power management:

processor : 2
vendor_id : GenuineIntel
cpu family : 6
model : 30
model name : Intel(R) Core(TM) i7 CPU Q 820 @ 1.73GHz
stepping : 5
cpu MHz : 1199.000
cache size : 8192 KB
physical id : 0
siblings : 8
core id : 1
cpu cores : 4
apicid : 2
initial apicid : 2
fpu : yes
fpu_exception : yes
cpuid level : 11
wp : yes
flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov
pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc aperfmperf pni dtes64 monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr pdcm sse4_1 sse4_2 popcnt lahf_lm ida dts tpr_shadow vnmi flexpriority ept vpid
bogomips : 3457.94
clflush size : 64
cache_alignment : 64
address sizes : 36 bits physical, 48 bits virtual
power management:

processor : 3
vendor_id : GenuineIntel
cpu family : 6
model : 30
model name : Intel(R) Core(TM) i7 CPU Q 820 @ 1.73GHz
stepping : 5
cpu MHz : 1199.000
cache size : 8192 KB
physical id : 0
siblings : 8
core id : 1
cpu cores : 4
apicid : 3
initial apicid : 3
fpu : yes
fpu_exception : yes
cpuid level : 11
wp : yes
flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov
pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc aperfmperf pni dtes64 monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr pdcm sse4_1 sse4_2 popcnt lahf_lm ida dts tpr_shadow vnmi flexpriority ept vpid
bogomips : 3457.94
clflush size : 64
cache_alignment : 64
address sizes : 36 bits physical, 48 bits virtual
power management:

processor : 4
vendor_id : GenuineIntel
cpu family : 6
model : 30
model name : Intel(R) Core(TM) i7 CPU Q 820 @ 1.73GHz
stepping : 5
cpu MHz : 1199.000
cache size : 8192 KB
physical id : 0
siblings : 8
core id : 2
cpu cores : 4
apicid : 4
initial apicid : 4
fpu : yes
fpu_exception : yes
cpuid level : 11
wp : yes
flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov
pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc aperfmperf pni dtes64 monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr pdcm sse4_1 sse4_2 popcnt lahf_lm ida dts tpr_shadow vnmi flexpriority ept vpid
bogomips : 3457.94
clflush size : 64
cache_alignment : 64
address sizes : 36 bits physical, 48 bits virtual
power management:

processor : 5
vendor_id : GenuineIntel
cpu family : 6
model : 30
model name : Intel(R) Core(TM) i7 CPU Q 820 @ 1.73GHz
stepping : 5
cpu MHz : 1199.000
cache size : 8192 KB
physical id : 0
siblings : 8
core id : 2
cpu cores : 4
apicid : 5
initial apicid : 5
fpu : yes
fpu_exception : yes
cpuid level : 11
wp : yes
flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov
pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc aperfmperf pni dtes64 monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr pdcm sse4_1 sse4_2 popcnt lahf_lm ida dts tpr_shadow vnmi flexpriority ept vpid
bogomips : 3457.94
clflush size : 64
cache_alignment : 64
address sizes : 36 bits physical, 48 bits virtual
power management:

processor : 6
vendor_id : GenuineIntel
cpu family : 6
model : 30
model name : Intel(R) Core(TM) i7 CPU Q 820 @ 1.73GHz
stepping : 5
cpu MHz : 1199.000
cache size : 8192 KB
physical id : 0
siblings : 8
core id : 3
cpu cores : 4
apicid : 6
initial apicid : 6
fpu : yes
fpu_exception : yes
cpuid level : 11
wp : yes
flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov
pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc aperfmperf pni dtes64 monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr pdcm sse4_1 sse4_2 popcnt lahf_lm ida dts tpr_shadow vnmi flexpriority ept vpid
bogomips : 3457.94
clflush size : 64
cache_alignment : 64
address sizes : 36 bits physical, 48 bits virtual
power management:

processor : 7
vendor_id : GenuineIntel
cpu family : 6
model : 30
model name : Intel(R) Core(TM) i7 CPU Q 820 @ 1.73GHz
stepping : 5
cpu MHz : 1199.000
cache size : 8192 KB
physical id : 0
siblings : 8
core id : 3
cpu cores : 4
apicid : 7
initial apicid : 7
fpu : yes
fpu_exception : yes
cpuid level : 11
wp : yes
flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov
pat pse36 clflush dts acpi mmx fxsr sse sse2 ss ht tm pbe syscall nx rdtscp lm constant_tsc arch_perfmon pebs bts rep_good nopl xtopology nonstop_tsc aperfmperf pni dtes64 monitor ds_cpl vmx smx est tm2 ssse3 cx16 xtpr pdcm sse4_1 sse4_2 popcnt lahf_lm ida dts tpr_shadow vnmi flexpriority ept vpid
bogomips : 3457.94
clflush size : 64
cache_alignment : 64
address sizes : 36 bits physical, 48 bits virtual
power management:
---

[8.3.] Module information (from /proc/modules):
---
btrfs 523995 0 - Live 0xffffffffa1167000
zlib_deflate 21723 1 btrfs, Live 0xffffffffa0f3c000
crc32c 3007 1 - Live 0xffffffffa0f36000
libcrc32c 1236 1 btrfs, Live 0xffffffffa02e5000
ufs 73550 0 - Live 0xffffffffa1153000
qnx4 7456 0 - Live 0xffffffffa0e67000
hfsplus 78184 0 - Live 0xffffffffa0ead000
hfs 47415 0 - Live 0xffffffffa0e4f000
minix 29133 0 - Live 0xffffffffa0e41000
ntfs 96715 0 - Live 0xffffffffa0e27000
msdos 8023 0 - Live 0xffffffffa0d8d000
jfs 181397 0 - Live 0xffffffffa0df0000
reiserfs 240655 0 - Live 0xffffffffa0da8000
usb_storage 50232 1 - Live 0xffffffffa0d99000
sha1_generic 2255 4 - Live 0xffffffffa0d8a000
ppp_mppe 6458 2 - Live 0xffffffffa02ea000
ppp_async 7912 1 - Live 0xffffffffa02e1000
crc_ccitt 1699 1 ppp_async, Live 0xffffffffa020e000
nls_utf8 1453 1 - Live 0xffffffffa0d90000
udf 86294 1 - Live 0xffffffffa0d72000
crc_itu_t 1739 1 udf, Live 0xffffffffa02e7000
nls_iso8859_1 4657 2 - Live 0xffffffffa02a7000
nls_cp437 6375 2 - Live 0xffffffffa0242000
vfat 10797 2 - Live 0xffffffffa01ed000
fat 55449 2 msdos,vfat, Live 0xffffffffa0d62000
binfmt_misc 7749 1 - Live 0xffffffffa0194000
vboxnetadp 5900 0 - Live 0xffffffffa01ca000
vboxnetflt 19935 0 - Live 0xffffffffa02c3000
vboxdrv 1817864 2 vboxnetadp,vboxnetflt, Live 0xffffffffa0f95000
parport_pc 30200 1 - Live 0xffffffffa02b9000
ppdev 6430 0 - Live 0xffffffffa017d000
nfsd 306110 13 - Live 0xffffffffa0f48000
nfs 319250 0 - Live 0xffffffffa0ee6000
lockd 74886 2 nfsd,nfs, Live 0xffffffffa0ed1000
fscache 50214 1 nfs, Live 0xffffffffa0ec2000
nfs_acl 2701 2 nfsd,nfs, Live 0xffffffffa01c3000
auth_rpcgss 44458 2 nfsd,nfs, Live 0xffffffffa029a000
sunrpc 227888 14 nfsd,nfs,lockd,nfs_acl,auth_rpcgss, Live 0xffffffffa0e73000
snd_hda_codec_hdmi 24503 4 - Live 0xffffffffa025e000
arc4 1497 4 - Live 0xffffffffa017a000
nvidia 10221078 42 - Live 0xffffffffa03a0000 (P)
iwlagn 241949 0 - Live 0xffffffffa0362000
iwlcore 107920 1 iwlagn, Live 0xffffffffa0345000
snd_hda_codec_conexant 47341 1 - Live 0xffffffffa02ab000
mac80211 268281 2 iwlagn,iwlcore, Live 0xffffffffa0301000
snd_hda_intel 25257 2 - Live 0xffffffffa0235000
xhci_hcd 65773 0 - Live 0xffffffffa02ee000
thinkpad_acpi 75854 0 - Live 0xffffffffa02cc000
snd_hda_codec 95642 3 snd_hda_codec_hdmi,snd_hda_codec_conexant,snd_hda_intel,
Live 0xffffffffa021b000
tpm_tis 9478 0 - Live 0xffffffffa0204000
tpm 16209 1 tpm_tis, Live 0xffffffffa01fe000
tpm_bios 6451 1 tpm, Live 0xffffffffa01a9000
i7core_edac 17692 0 - Live 0xffffffffa01f7000
psmouse 59542 0 - Live 0xffffffffa01dc000
video 13174 0 - Live 0xffffffffa01f1000
cfg80211 162281 3 iwlagn,iwlcore,mac80211, Live 0xffffffffa0270000
edac_core 46183 3 i7core_edac, Live 0xffffffffa01ce000
lp 10021 0 - Live 0xffffffffa01be000
nvram 7693 1 thinkpad_acpi, Live 0xffffffffa019d000
snd_hwdep 6546 1 snd_hda_codec, Live 0xffffffffa0161000
snd_seq_midi 5964 0 - Live 0xffffffffa004b000
snd_pcm 88491 3 snd_hda_codec_hdmi,snd_hda_intel,snd_hda_codec, Live
0xffffffffa0246000
snd_rawmidi 22012 1 snd_seq_midi, Live 0xffffffffa0268000
snd_seq_midi_event 7323 1 snd_seq_midi, Live 0xffffffffa023e000
shpchp 28850 0 - Live 0xffffffffa0211000
serio_raw 5006 0 - Live 0xffffffffa020a000
joydev 11287 0 - Live 0xffffffffa01c5000
snd_seq 57011 2 snd_seq_midi,snd_seq_midi_event, Live 0xffffffffa01ae000
snd_timer 23276 2 snd_pcm,snd_seq, Live 0xffffffffa01a1000
snd_seq_device 6912 3 snd_seq_midi,snd_rawmidi,snd_seq, Live 0xffffffffa0199000
uvcvideo 64071 0 - Live 0xffffffffa0182000
videodev 78073 1 uvcvideo, Live 0xffffffffa0164000
v4l1_compat 15679 2 uvcvideo,videodev, Live 0xffffffffa005b000
v4l2_compat_ioctl32 11518 1 videodev, Live 0xffffffffa0044000
output 2495 1 video, Live 0xffffffffa0083000
snd 63608 15 snd_hda_codec_hdmi,snd_hda_codec_conexant,snd_hda_intel,thinkpad_acpi,snd_hda_codec,snd_hwdep,snd_rawmidi,snd_pcm,snd_seq,snd_timer,snd_seq_device, Live 0xffffffffa014f000
parport 37263 3 parport_pc,ppdev,lp, Live 0xffffffffa0143000
soundcore 1240 1 snd, Live 0xffffffffa0048000
snd_page_alloc 8748 2 snd_hda_intel,snd_pcm, Live 0xffffffffa002b000
xfs 765376 2 - Live 0xffffffffa0086000
exportfs 4162 2 nfsd,xfs, Live 0xffffffffa004f000
usbhid 40063 0 - Live 0xffffffffa0077000
hid 84420 1 usbhid, Live 0xffffffffa0060000
mmc_block 11127 2 - Live 0xffffffffa0026000
sdhci_pci 8166 0 - Live 0xffffffffa0038000
sdhci 18986 1 sdhci_pci, Live 0xffffffffa003d000
ahci 21262 3 - Live 0xffffffffa0053000
e1000e 146076 0 - Live 0xffffffffa0000000
libahci 22574 1 ahci, Live 0xffffffffa0030000
---

[8.4.] Loaded driver and hardware information (/proc/ioports, /proc/iomem)
Note: I've switched external disk on again before collected this information. ioports:
0000-0cf7 : PCI Bus 0000:00
0000-001f : dma1
0020-0021 : pic1
0040-0043 : timer0
0050-0053 : timer1
0060-0060 : keyboard
0062-0062 : EC data
0064-0064 : keyboard
0066-0066 : EC cmd
0070-0071 : rtc0
0080-008f : dma page reg
00a0-00a1 : pic2
00c0-00df : dma2
00f0-00ff : fpu
0378-037a : parport0
03c0-03df : vga+
0800-080f : pnp 00:03
0cf8-0cff : PCI conf1
0d00-ffff : PCI Bus 0000:00
1000-107f : pnp 00:03

    1000-1003 : ACPI PM1a_EVT_BLK
    1004-1005 : ACPI PM1a_CNT_BLK
    1008-100b : ACPI PM_TMR
    1010-1015 : ACPI CPU throttle
    1020-102f : ACPI GPE0_BLK
    1050-1050 : ACPI PM2_CNT_BLK
  1180-11ff : pnp 00:03
  15e0-15ef : pnp 00:03
  1600-1641 : pnp 00:03
  164e-164f : pnp 00:03
  1808-180b : 0000:00:1f.2
    1808-180b : ahci
  180c-180f : 0000:00:1f.2
    180c-180f : ahci
  1810-1817 : 0000:00:1f.2
    1810-1817 : ahci
  1818-181f : 0000:00:1f.2
    1818-181f : ahci
  1820-183f : 0000:00:19.0
  1840-185f : 0000:00:1f.2
    1840-185f : ahci
  1860-187f : 0000:00:1f.3
  2000-2fff : PCI Bus 0000:01
    2000-207f : 0000:01:00.0

3000-3fff : PCI Bus 0000:05
---
iomem:
---
00000000-0000ffff : reserved
00010000-0009e7ff : System RAM
0009e800-0009ffff : reserved
000a0000-000bffff : PCI Bus 0000:00
000c0000-000c3fff : pnp 00:00
000c4000-000c7fff : pnp 00:00
000c8000-000cbfff : pnp 00:00
000cc000-000cffff : pnp 00:00
000d2000-000d3fff : reserved
000d4000-000d7fff : PCI Bus 0000:00
000d8000-000dbfff : PCI Bus 0000:00
000dc000-000fffff : reserved
00100000-bba7bfff : System RAM
01000000-015a9d35 : Kernel code
015a9d36-01aa4aef : Kernel data
01b94000-01cc007f : Kernel bss
2f000000-36ffffff : Crash kernel
bba7c000-bba81fff : reserved
bba82000-bbb48fff : System RAM
bbb49000-bbb5bfff : reserved
bbb5c000-bbbdcfff : ACPI Non-volatile Storage
bbbdd000-bbc0efff : reserved
bbc0f000-bbc5cfff : System RAM
bbc5d000-bbe67fff : reserved
bbe68000-bbee7fff : ACPI Non-volatile Storage
bbee8000-bbf0efff : reserved
bbf0f000-bbf17fff : System RAM
bbf18000-bbf1efff : reserved
bbf1f000-bbf6dfff : System RAM
bbf6e000-bbf79fff : ACPI Non-volatile Storage
bbf7a000-bbf7cfff : ACPI Tables
bbf7d000-bbf80fff : ACPI Non-volatile Storage
bbf81000-bbf81fff : ACPI Tables
bbf82000-bbf8afff : ACPI Non-volatile Storage
bbf8b000-bbf8bfff : ACPI Tables
bbf8c000-bbf9efff : ACPI Non-volatile Storage
bbf9f000-bbffefff : ACPI Tables
bbfff000-bbffffff : System RAM
bc000000-bdffffff : reserved
bf800000-bfffffff : reserved
c0000000-febfffff : PCI Bus 0000:00
c0000000-c0000fff : pnp 00:03
cc000000-cdefffff : PCI Bus 0000:01

    cc000000-ccffffff : 0000:01:00.0
      cc000000-ccffffff : nvidia
    cd000000-cd07ffff : 0000:01:00.0
    cdefc000-cdefffff : 0000:01:00.1
      cdefc000-cdefffff : ICH HD audio
  ce000000-dfffffff : PCI Bus 0000:01
    ce000000-cfffffff : 0000:01:00.0
    d0000000-dfffffff : 0000:01:00.0
  e0000000-efffffff : PCI MMCONFIG 0000 [bus 00-ff]
    e0000000-efffffff : reserved
      e0000000-efffffff : pnp 00:03
  f0000000-f1ffffff : PCI Bus 0000:05
  f2000000-f20fffff : PCI Bus 0000:03
    f2000000-f2001fff : 0000:03:00.0
      f2000000-f2001fff : iwlagn
  f2100000-f21fffff : PCI Bus 0000:0d
    f2100000-f21000ff : 0000:0d:00.0
      f2100000-f21000ff : mmc0
    f2100400-f21004ff : 0000:0d:00.1
  f2200000-f22fffff : PCI Bus 0000:0f
    f2200000-f2201fff : 0000:0f:00.0
      f2200000-f2201fff : xhci_hcd
  f2300000-f23fffff : PCI Bus 0000:17
    f2300000-f23000ff : 0000:17:00.0
      f2300000-f23000ff : mmc1
  f2600000-f261ffff : 0000:00:19.0
    f2600000-f261ffff : e1000e
  f2620000-f2623fff : 0000:00:1b.0
    f2620000-f2623fff : ICH HD audio
  f2625000-f2625fff : 0000:00:19.0
    f2625000-f2625fff : e1000e
  f2626000-f2626fff : pnp 00:03
  f2627000-f26277ff : 0000:00:1f.2
    f2627000-f26277ff : ahci
  f2627800-f262780f : 0000:00:16.0
  f2628000-f26283ff : 0000:00:1a.0
    f2628000-f26283ff : ehci_hcd
  f2628400-f26287ff : 0000:00:1d.0
    f2628400-f26287ff : ehci_hcd

f2628800-f26288ff : 0000:00:1f.3
f2700000-f27fffff : PCI Bus 0000:05
feaff000-feafffff : reserved
fec00000-fec0ffff : reserved
fec00000-fec003ff : IOAPIC 0
fed00000-fed003ff : HPET 0
fed00000-fed003ff : reserved
fed10000-fed13fff : pnp 00:03
fed18000-fed18fff : pnp 00:03
fed19000-fed19fff : pnp 00:03
fed1c000-fed8ffff : reserved
fed1c000-fed1ffff : pnp 00:03
fed45000-fed4bfff : pnp 00:03
fee00000-fee00fff : Local APIC
fee00000-fee00fff : reserved
ff000000-ffffffff : reserved
100000000-43fffffff : System RAM
---

[8.5.] PCI information ('lspci -vvv' as root) - attached.

[8.6.] SCSI information (from /proc/scsi/scsi) Attached devices:
Host: scsi0 Channel: 00 Id: 00 Lun: 00
Vendor: ATA Model: ST9500420AS Rev: 0003
Type: Direct-Access ANSI SCSI revision: 05
Host: scsi1 Channel: 00 Id: 00 Lun: 00
Vendor: Optiarc Model: DVD RW AD-7700H Rev: 1.FA
Type: CD-ROM ANSI SCSI revision: 05
Host: scsi8 Channel: 00 Id: 00 Lun: 00
Vendor: HTC Model: Android Phone Rev: 0100
Type: Direct-Access ANSI SCSI revision: 02
Host: scsi5 Channel: 00 Id: 00 Lun: 00
Vendor: ATA Model: WDC WD1500HLFS-0 Rev: 04.0
Type: Direct-Access ANSI SCSI revision: 05

[8.7.] Other information that might be relevant to the problem
(please look in /proc and include all information that you think to be relevant):
I'm willing to assist / reproduce, but I lack the knowledge to decide by myself.

Signature · 3 lines
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.
author
#1 lore raw

[Bug 30802] exception & eSATA hard link resets

https://bugzilla.kernel.org/show_bug.cgi?id=30802

--- Comment #1 from Damjan <[email protected]> 2011-03-09 13:55:40 --- Created an attachment (id=50452)
--> (https://bugzilla.kernel.org/attachment.cgi?id=50452)
kernel .config file

forgot to add it to the archive before

Signature · 3 lines
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.
author
#3 lore raw

[Bug 30802] exception & eSATA hard link resets

In reply to [email protected]

https://bugzilla.kernel.org/show_bug.cgi?id=30802

Robert Hancock <[email protected]> changed:

What |Removed |Added
----------------------------------------------------------------------------
CC| |[email protected]

--- Comment #3 from Robert Hancock <[email protected]> 2011-03-10 02:23:40 --- So you're getting stuff like:

[20698.759685] ata6: exception Emask 0x10 SAct 0x0 SErr 0x4050000 action 0xe
frozen
[20698.759691] ata6: irq_stat 0x00400040, connection status changed
[20698.759697] ata6: SError: { PHYRdyChg CommWake DevExch }
[20698.759706] ata6: hard resetting link

Your controller's reporting a bunch of link state change events occurring. My first inclination is to suspect a problem with the eSATA cable or drive enclosure. A lot of these seem to be rather flaky as far as power and/or the solidity of the cable connections.

Does it recover if you disconnect/power off and reconnect the drive?

Signature · 3 lines
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.
author
#4 lore raw

[Bug 30802] exception & eSATA hard link resets

In reply to [email protected]

https://bugzilla.kernel.org/show_bug.cgi?id=30802

--- Comment #4 from Anonymous Emailer <[email protected]> 2011-03-10 08:51:08 ---
Reply-To: [email protected]

Hi,
it does not recover. I have to reboot.
Br,

2011/3/10 <[email protected]>

Quoted 38 lines

https://bugzilla.kernel.org/show_bug.cgi?id=30802

Robert Hancock <[email protected]> changed:

What |Removed |Added

----------------------------------------------------------------------------
CC| |[email protected]

--- Comment #3 from Robert Hancock <[email protected]> 2011-03-10 02:23:40 ---
So you're getting stuff like:

[20698.759685] ata6: exception Emask 0x10 SAct 0x0 SErr 0x4050000 action
0xe
frozen
[20698.759691] ata6: irq_stat 0x00400040, connection status changed
[20698.759697] ata6: SError: { PHYRdyChg CommWake DevExch }
[20698.759706] ata6: hard resetting link

Your controller's reporting a bunch of link state change events occurring. My
first inclination is to suspect a problem with the eSATA cable or drive enclosure. A lot of these seem to be rather flaky as far as power and/or the
solidity of the cable connections.

Does it recover if you disconnect/power off and reconnect the drive?

--
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You reported the bug.

Signature · 3 lines
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.
author
#5 lore raw

[Bug 30802] exception & eSATA hard link resets

In reply to [email protected]

https://bugzilla.kernel.org/show_bug.cgi?id=30802

--- Comment #5 from Anonymous Emailer <[email protected]> 2011-03-10 10:21:14 ---
Reply-To: [email protected]

I've checked my answer.
test:
- large files are copied to eSATA connected disk (meanwhile I've checked the cables - moved a bit while copying was in progress and it had no impact - no reset during that period)
- after many "hard link resets" the connection finally crashes (lost page)
- disk is switched off & on
- connection seems to be established for few seconds, but then resets (fs has not been mounted after that - at least, I did not try to) and work with the disk is impossible after that.

Here is the log:

Mar 10 11:08:59 think kernel: [11175.740129] ata6: hard resetting link
Mar 10 11:09:02 think kernel: [11179.079216] ata6: SATA link up 1.5 Gbps
(SStatus 113 SControl 310)
Mar 10 11:09:02 think kernel: [11179.085015] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:02 think kernel: [11179.109623] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:02 think kernel: [11179.113161] ata6.00: configured for UDMA/33
Mar 10 11:09:02 think kernel: [11179.129241] ata6: EH complete
Mar 10 11:09:02 think kernel: [11179.212399] ata6: hard resetting link
Mar 10 11:09:05 think kernel: [11182.537511] ata6: SATA link up 1.5 Gbps
(SStatus 113 SControl 310)
Mar 10 11:09:05 think kernel: [11182.542964] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:05 think kernel: [11182.565409] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:05 think kernel: [11182.569360] ata6.00: configured for UDMA/33
Mar 10 11:09:05 think kernel: [11182.587467] ata6: EH complete
Mar 10 11:09:06 think kernel: [11182.698541] ata6: hard resetting link
Mar 10 11:09:09 think kernel: [11186.025687] ata6: SATA link up 1.5 Gbps
(SStatus 113 SControl 310)
Mar 10 11:09:09 think kernel: [11186.032309] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:09 think kernel: [11186.036834] ata6.00: failed to read native
max address (err_mask=0x100)
Mar 10 11:09:09 think kernel: [11186.036839] ata6.00: HPA support seems
broken, skipping HPA handling
Mar 10 11:09:14 think kernel: [11191.023150] ata6: hard resetting link
Mar 10 11:09:14 think kernel: [11191.372977] ata6: SATA link up 1.5 Gbps
(SStatus 113 SControl 310)
Mar 10 11:09:14 think kernel: [11191.376316] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:14 think kernel: [11191.383139] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:14 think kernel: [11191.386158] ata6.00: configured for UDMA/33
Mar 10 11:09:14 think kernel: [11191.403016] ata6: EH complete
Mar 10 11:09:22 think kernel: [11199.269021] ata6: hard resetting link
Mar 10 11:09:25 think kernel: [11202.617252] ata6: SATA link up 1.5 Gbps
(SStatus 113 SControl 310)
Mar 10 11:09:25 think kernel: [11202.625230] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:25 think kernel: [11202.632379] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:25 think kernel: [11202.635396] ata6.00: configured for UDMA/33
Mar 10 11:09:25 think kernel: [11202.635400] ata6.00: retrying FLUSH 0xea
Emask 0x10
Mar 10 11:09:25 think kernel: [11202.647178] ata6: EH complete
Mar 10 11:09:26 think kernel: [11202.676248] ata6: hard resetting link
Mar 10 11:09:29 think kernel: [11206.055580] ata6: SATA link up 1.5 Gbps
(SStatus 113 SControl 310)
Mar 10 11:09:29 think kernel: [11206.059182] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:29 think kernel: [11206.067332] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:29 think kernel: [11206.071322] ata6.00: configured for UDMA/33
Mar 10 11:09:29 think kernel: [11206.085627] ata6: EH complete
Mar 10 11:09:29 think kernel: [11206.096685] ata6: hard resetting link
Mar 10 11:09:32 think kernel: [11209.483767] ata6: SATA link up 1.5 Gbps
(SStatus 113 SControl 310)
Mar 10 11:09:32 think kernel: [11209.487399] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:32 think kernel: [11209.495411] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:32 think kernel: [11209.499386] ata6.00: configured for UDMA/33
Mar 10 11:09:32 think kernel: [11209.513932] ata6: EH complete
Mar 10 11:09:37 think kernel: [11214.460238] ata6: hard resetting link
Mar 10 11:09:41 think kernel: [11217.839611] ata6: SATA link up 1.5 Gbps
(SStatus 113 SControl 310)
Mar 10 11:09:41 think kernel: [11217.843020] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:41 think kernel: [11217.850325] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:41 think kernel: [11217.853379] ata6.00: configured for UDMA/33
Mar 10 11:09:41 think kernel: [11217.869737] ata6: EH complete
Mar 10 11:09:47 think kernel: [11223.951737] ata6: hard resetting link
Mar 10 11:09:50 think kernel: [11227.274784] ata6: SATA link up 1.5 Gbps
(SStatus 113 SControl 310)
Mar 10 11:09:50 think kernel: [11227.279504] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:50 think kernel: [11227.286833] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:50 think kernel: [11227.290477] ata6.00: configured for UDMA/33
Mar 10 11:09:50 think kernel: [11227.304913] ata6: EH complete
Mar 10 11:09:50 think kernel: [11227.384377] ata6: hard resetting link
Mar 10 11:09:54 think kernel: [11230.763016] ata6: SATA link up 1.5 Gbps
(SStatus 113 SControl 310)
Mar 10 11:09:54 think kernel: [11230.766595] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:54 think kernel: [11230.774235] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:09:54 think kernel: [11230.777396] ata6.00: configured for UDMA/33
Mar 10 11:09:54 think kernel: [11230.793144] ata6: EH complete
Mar 10 11:10:06 think kernel: [11243.627307] ata6: hard resetting link
Mar 10 11:10:10 think kernel: [11246.954803] ata6: SATA link up 1.5 Gbps
(SStatus 113 SControl 310)
Mar 10 11:10:10 think kernel: [11246.958246] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:10:10 think kernel: [11246.965996] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:10:10 think kernel: [11246.969984] ata6.00: configured for UDMA/33
Mar 10 11:10:10 think kernel: [11246.984956] ata6: EH complete
Mar 10 11:10:26 think kernel: [11262.886673] ata6: hard resetting link
Mar 10 11:10:27 think kernel: [11264.206101] ata6: SATA link down (SStatus 0
SControl 310)
Mar 10 11:10:27 think kernel: [11264.251554] ata6: hard resetting link
Mar 10 11:10:28 think kernel: [11264.775815] ata6: SATA link down (SStatus 0
SControl 310)
Mar 10 11:10:28 think kernel: [11264.824051] ata6: hard resetting link
Mar 10 11:10:28 think kernel: [11265.345533] ata6: SATA link down (SStatus 0
SControl 310)
Mar 10 11:10:28 think kernel: [11265.345551] ata6.00: disabled
Mar 10 11:10:28 think kernel: [11265.345562] ata6: limiting SATA link speed
to 1.5 Gbps
Mar 10 11:10:28 think kernel: [11265.365635] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.365642] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.365650] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.365652]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.365657]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.365659] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.365662] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 93 d7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366108] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366111] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366114] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366116]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366123]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366125] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366128] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 9b d7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366152] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366155] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366158] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366160]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366167]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366171] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366174] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 a3 d7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366185] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366188] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366192] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366194]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366201]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366205] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366208] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 ab d7 00 00 08 00
Mar 10 11:10:28 think kernel: [11265.366220] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366223] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366226] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366228]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366236]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366239] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366242] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 ab df 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366255] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366257] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366261] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366262]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366270]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366274] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366277] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 af df 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366289] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366292] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366295] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366297]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366304]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366308] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366311] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 b3 df 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366323] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366326] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366329] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366331]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366339]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366342] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366345] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 b7 df 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366358] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366361] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366364] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366366]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366374]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366378] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366381] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 bb df 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366394] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366397] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366400] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366402]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366410]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366413] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366417] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 bf df 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366429] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366432] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366435] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366437]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366445]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366448] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366451] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 c3 df 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366464] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366466] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366470] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366471]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366479]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366482] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366485] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 c7 df 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366496] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366499] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366502] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366504]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366512]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366515] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366518] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 cb df 00 00 08 00
Mar 10 11:10:28 think kernel: [11265.366531] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366534] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366538] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366540]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366547]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366551] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366554] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 cb e7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366566] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366569] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366573] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366574]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366582]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366585] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366588] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 cf e7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366602] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366604] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366608] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366610]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366617]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366621] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366624] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 d3 e7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366637] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366640] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366643] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366645]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366652]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366656] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366659] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 d7 e7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366672] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366675] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366678] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366680]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366688]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366691] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366694] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 db e7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366707] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366709] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366713] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366714]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366722]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366725] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366731] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 df e7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366743] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366746] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366749] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366751]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366758]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366761] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366765] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 e3 e7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366784] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366787] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366791] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366793]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366802]         00 b1 df
Mar 10 11:10:28 think kernel: [11265.366806] e7
Mar 10 11:10:28 think kernel: [11265.366808] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366811] sd 5:0:0:0: [sdb] CDB:
Mar 10 11:10:28 think kernel: [11265.366814] Write(10)
Mar 10 11:10:28 think kernel: [11265.366817] :
Mar 10 11:10:28 think kernel: [11265.366820]  2a 00 00 b1 e7 e7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366835] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366838] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366841] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366843]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366851]         00
Mar 10 11:10:28 think kernel: [11265.366854] b1 df
Mar 10 11:10:28 think kernel: [11265.366857] e7
Mar 10 11:10:28 think kernel: [11265.366860]
Mar 10 11:10:28 think kernel: [11265.366863] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366865] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 7b 9f 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366878] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366881] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366884] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366886]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366894]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366897] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366900] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 7f 9f 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366913] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366916] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366919] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366921]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366929]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366932] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366935] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 83 9f 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366947] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366950] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366954] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366955]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366963]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.366967] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.366970] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 87 9f 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.366981] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.366984] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.366987] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.366989]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.366997]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.367000] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.367003] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 8b 9f 00 00 38 00
Mar 10 11:10:28 think kernel: [11265.367016] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.367019] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.367022] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.367024]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.367032]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.367035] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.367038] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 8b d7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.367051] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.367054] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.367057] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.367059]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.367066]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.367070] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.367073] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 8f d7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.367085] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.367088] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.367091] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.367093]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.367100]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.367103] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.367106] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 97 d7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.367120] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.367122] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.367125] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.367127]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.367135]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.367139] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.367142] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 9f d7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.367155] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Mar 10 11:10:28 think kernel: [11265.367158] sd 5:0:0:0: [sdb]  Sense Key :
Aborted Command [current] [descriptor]
Mar 10 11:10:28 think kernel: [11265.367161] Descriptor sense data with
sense descriptors (in hex):
Mar 10 11:10:28 think kernel: [11265.367163]         72 0b 00 00 00 00 00 0c
00 0a 80 00 00 00 00 00
Mar 10 11:10:28 think kernel: [11265.367171]         00 b1 df e7
Mar 10 11:10:28 think kernel: [11265.367174] sd 5:0:0:0: [sdb]  Add. Sense:
No additional sense information
Mar 10 11:10:28 think kernel: [11265.367177] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 a7 d7 00 04 00 00
Mar 10 11:10:28 think kernel: [11265.367189] ata6: EH complete
Mar 10 11:10:28 think kernel: [11265.367201] lost page write due to I/O
error on sdb1
Mar 10 11:10:28 think kernel: [11265.367206] lost page write due to I/O
error on sdb1
Mar 10 11:10:28 think kernel: [11265.367211] lost page write due to I/O
error on sdb1
Mar 10 11:10:28 think kernel: [11265.367216] lost page write due to I/O
error on sdb1
Mar 10 11:10:28 think kernel: [11265.367220] lost page write due to I/O
error on sdb1
Mar 10 11:10:28 think kernel: [11265.367224] lost page write due to I/O
error on sdb1
Mar 10 11:10:28 think kernel: [11265.367229] lost page write due to I/O
error on sdb1
Mar 10 11:10:28 think kernel: [11265.367233] lost page write due to I/O
error on sdb1
Mar 10 11:10:28 think kernel: [11265.367237] lost page write due to I/O
error on sdb1
Mar 10 11:10:28 think kernel: [11265.367242] lost page write due to I/O
error on sdb1
Mar 10 11:10:28 think kernel: [11265.367723] ata6.00: detaching (SCSI
5:0:0:0)
Mar 10 11:10:28 think kernel: [11265.367787] sd 5:0:0:0: [sdb] Unhandled
error code
Mar 10 11:10:28 think kernel: [11265.367789] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_NO_CONNECT driverbyte=DRIVER_OK
Mar 10 11:10:28 think kernel: [11265.367793] sd 5:0:0:0: [sdb] CDB:
Write(10): 2a 00 00 b1 eb e7 00 00 08 00
Mar 10 11:10:28 think kernel: [11265.396490] ata6: limiting SATA link speed
to 1.5 Gbps
Mar 10 11:10:28 think kernel: [11265.396494] ata6: hard resetting link
Mar 10 11:10:28 think kernel: [11265.586251] xfs_force_shutdown(sdb1,0x2)
called from line 926 of file fs/xfs/xfs_log.c.  Return address =
0xffffffffa00e18fb
Mar 10 11:10:28 think kernel: [11265.586272] Filesystem "sdb1":
xfs_log_force: error 5 returned.
Mar 10 11:10:28 think kernel: [11265.586276] xfs_force_shutdown(sdb1,0x1)
called from line 1040 of file fs/xfs/linux-2.6/xfs_buf.c.  Return address =
0xffffffffa00fd8f3
Mar 10 11:10:29 think kernel: [11266.015634] sd 5:0:0:0: [sdb] Synchronizing
SCSI cache
Mar 10 11:10:30 think kernel: [11266.975886] Filesystem "sdb1":
xfs_log_force: error 5 returned.
Mar 10 11:10:30 think kernel: [11266.975933] Filesystem "sdb1":
xfs_log_force: error 5 returned.
Mar 10 11:10:31 think kernel: [11267.654423] ata6: reset failed (errno=-32),
retrying in 8 secs
Mar 10 11:10:38 think kernel: [11275.390583] ata6: hard resetting link
Mar 10 11:10:41 think kernel: [11277.939232] ata6: reset failed (errno=-32),
retrying in 8 secs
Mar 10 11:10:48 think kernel: [11285.385359] ata6: hard resetting link
Mar 10 11:10:53 think kernel: [11290.273004] ata6: SATA link up 1.5 Gbps
(SStatus 113 SControl 310)
Mar 10 11:10:53 think kernel: [11290.276690] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:10:53 think kernel: [11290.290790] ata6.00: ATA-8: WDC
WD1500HLFS-01G6U4, 04.04V06, max UDMA/133
Mar 10 11:10:53 think kernel: [11290.290796] ata6.00: 293046768 sectors,
multi 0: LBA48 NCQ (depth 31/32), AA
Mar 10 11:10:53 think kernel: [11290.294448] ata6.00: ACPI cmd
f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Mar 10 11:10:53 think kernel: [11290.298463] ata6.00: configured for
UDMA/133
Mar 10 11:10:53 think kernel: [11290.312962] ata6: EH complete
Mar 10 11:10:53 think kernel: [11290.313299] sd 5:0:0:0: [sdb] Stopping disk
Mar 10 11:10:54 think kernel: [11291.041901] scsi 5:0:0:0: Direct-Access
ATA      WDC WD1500HLFS-0 04.0 PQ: 0 ANSI: 5
Mar 10 11:10:54 think kernel: [11291.042181] sd 5:0:0:0: [sdb] 293046768
512-byte logical blocks: (150 GB/139 GiB)
Mar 10 11:10:54 think kernel: [11291.042271] sd 5:0:0:0: Attached scsi
generic sg2 type 0
Mar 10 11:10:54 think kernel: [11291.042314] sd 5:0:0:0: [sdb] Write Protect
is off
Mar 10 11:10:54 think kernel: [11291.042393] sd 5:0:0:0: [sdb] Write cache:
enabled, read cache: enabled, doesn't support DPO or FUA
Mar 10 11:10:55 think kernel: [11292.308399]  sdb: sdb1 sdb2
Mar 10 11:10:55 think kernel: [11292.308947] sd 5:0:0:0: [sdb] Attached SCSI
disk
Mar 10 11:11:14 think kernel: [11311.494015] ata6: hard resetting link
Mar 10 11:11:16 think kernel: [11313.321337] ata6: SATA link down (SStatus 0
SControl 310)
Mar 10 11:11:16 think kernel: [11313.363772] ata6: hard resetting link
Mar 10 11:11:17 think kernel: [11313.951130] ata6: SATA link down (SStatus 0
SControl 310)
Mar 10 11:11:22 think kernel: [11318.948481] ata6: hard resetting link
Mar 10 11:11:23 think kernel: [11319.798058] ata6: SATA link down (SStatus 0
SControl 310)
Mar 10 11:11:23 think kernel: [11319.798081] ata6.00: disabled
Mar 10 11:11:23 think kernel: [11319.798097] ata6: limiting SATA link speed
to 1.5 Gbps
Mar 10 11:11:23 think kernel: [11319.817999] ata6: EH complete
Mar 10 11:11:23 think kernel: [11319.818012] ata6.00: detaching (SCSI
5:0:0:0)
Mar 10 11:11:23 think kernel: [11319.841998] ata6: limiting SATA link speed
to 1.5 Gbps
Mar 10 11:11:23 think kernel: [11319.842005] ata6: hard resetting link
Mar 10 11:11:23 think kernel: [11319.898111] sd 5:0:0:0: [sdb] Synchronizing
SCSI cache
Mar 10 11:11:24 think kernel: [11321.087430] ata6: SATA link down (SStatus 0
SControl 310)
Mar 10 11:11:24 think kernel: [11321.107395] ata6: EH complete
Mar 10 11:11:24 think kernel: [11321.107459] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK
Mar 10 11:11:24 think kernel: [11321.107466] sd 5:0:0:0: [sdb] Stopping disk
Mar 10 11:11:24 think kernel: [11321.107479] sd 5:0:0:0: [sdb] START_STOP
FAILED
Mar 10 11:11:24 think kernel: [11321.107482] sd 5:0:0:0: [sdb]  Result:
hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK
Mar 10 11:11:24 think kernel: [11321.142143] ata6: limiting SATA link speed
to 1.5 Gbps
Mar 10 11:11:24 think kernel: [11321.142148] ata6: hard resetting link
Mar 10 11:11:25 think kernel: [11322.386749] ata6: SATA link down (SStatus 0
SControl 310)
Mar 10 11:11:25 think kernel: [11322.406674] ata6: EH complete
Mar 10 11:11:25 think kernel: [11322.445850] ata6: limiting SATA link speed
to 1.5 Gbps
Mar 10 11:11:25 think kernel: [11322.445855] ata6: hard resetting link
Mar 10 11:11:27 think kernel: [11323.686135] ata6: SATA link down (SStatus 0
SControl 310)
Mar 10 11:11:27 think kernel: [11323.706029] ata6: EH complete
Mar 10 11:11:27 think kernel: [11323.750262] ata6: limiting SATA link speed
to 1.5 Gbps
Mar 10 11:11:27 think kernel: [11323.750267] ata6: hard resetting link
Mar 10 11:11:28 think kernel: [11324.995440] ata6: SATA link down (SStatus 0
SControl 310)
Mar 10 11:11:28 think kernel: [11325.015357] ata6: EH complete
Mar 10 11:11:28 think kernel: [11325.062671] ata6: limiting SATA link speed
to 1.5 Gbps
Mar 10 11:11:28 think kernel: [11325.062675] ata6: hard resetting link
Mar 10 11:11:29 think kernel: [11326.124862] ata6: SATA link down (SStatus 0
SControl 310)
Mar 10 11:11:29 think kernel: [11326.144756] ata6: EH complete

2011/3/10 <[email protected]>

Quoted 38 lines

https://bugzilla.kernel.org/show_bug.cgi?id=30802

Robert Hancock <[email protected]> changed:

What |Removed |Added

----------------------------------------------------------------------------
CC| |[email protected]

--- Comment #3 from Robert Hancock <[email protected]> 2011-03-10 02:23:40 ---
So you're getting stuff like:

[20698.759685] ata6: exception Emask 0x10 SAct 0x0 SErr 0x4050000 action
0xe
frozen
[20698.759691] ata6: irq_stat 0x00400040, connection status changed
[20698.759697] ata6: SError: { PHYRdyChg CommWake DevExch }
[20698.759706] ata6: hard resetting link

Your controller's reporting a bunch of link state change events occurring. My
first inclination is to suspect a problem with the eSATA cable or drive enclosure. A lot of these seem to be rather flaky as far as power and/or the
solidity of the cable connections.

Does it recover if you disconnect/power off and reconnect the drive?

--
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You reported the bug.

Signature · 3 lines
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.
author
#6 lore raw

[Bug 30802] exception & eSATA hard link resets

In reply to [email protected]

https://bugzilla.kernel.org/show_bug.cgi?id=30802

Tejun Heo <[email protected]> changed:

What |Removed |Added
----------------------------------------------------------------------------
CC| |[email protected]

--- Comment #6 from Tejun Heo <[email protected]> 2011-03-10 10:40:22 --- First of all, please don't paste kernel log in-line and don't attach them as tar.gz either unless the file is really big. Attach them as separate text/plain files.

It definitely looks like hardware problem to me. You're trying to use wd raptor 15k rpm drive, right? I don't know your setup but it could be that the enclosure you're using isn't upto the task power-wise. The FLUSH_CACHE failure combined with PHY going down is also indicative of power problems. Can you please do the followings?

1. Boot and run "smartctl -a" on the hard drive.
2. Trigger the problem.
3. Reset the computer but don't power cycle the enclosure.
4. Run "smartctl -a" on the drive again.

Post the two outputs from the smartctl.

Thanks.

Signature · 3 lines
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.
author
#7 lore raw

[Bug 30802] exception & eSATA hard link resets

In reply to [email protected]

https://bugzilla.kernel.org/show_bug.cgi?id=30802

--- Comment #7 from Anonymous Emailer <[email protected]> 2011-03-10 19:40:20 ---
Reply-To: [email protected]

Hi,
you are right in all points:
- it is that kind of disk
- I was not using original power supply, because I thought the stronger one with the more convenient switch should work... Maybe switch is broken, but doesn't matter now.

I've asked the dealer for the original and it works now. I've tested with more demanding tests and not a single problem reported. Issue can be closed.

Thank you very much for *excellent* support (among best in my 15 years professional IT career),
Damjan

P.S.: I'll obey guidelines about report in case I'll be in the position to do it again (not likely though). However, I intend to attach logs that way at the very beginning, but web UI looked for me like there can be only one file attached. Therefore I've decided for an archive. Sorry.

2011/3/10 <[email protected]>

Quoted 41 lines

https://bugzilla.kernel.org/show_bug.cgi?id=30802

Tejun Heo <[email protected]> changed:

What |Removed |Added

----------------------------------------------------------------------------
CC| |[email protected]

--- Comment #6 from Tejun Heo <[email protected]> 2011-03-10 10:40:22 --- First of all, please don't paste kernel log in-line and don't attach them as
tar.gz either unless the file is really big. Attach them as separate text/plain files.

It definitely looks like hardware problem to me. You're trying to use wd raptor 15k rpm drive, right? I don't know your setup but it could be that the
enclosure you're using isn't upto the task power-wise. The FLUSH_CACHE failure
combined with PHY going down is also indicative of power problems. Can you please do the followings?

1. Boot and run "smartctl -a" on the hard drive.
2. Trigger the problem.
3. Reset the computer but don't power cycle the enclosure.
4. Run "smartctl -a" on the drive again.

Post the two outputs from the smartctl.

Thanks.

--
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You reported the bug.

Signature · 3 lines
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.
author
#8 lore raw

[Bug 30802] exception & eSATA hard link resets

In reply to [email protected]

https://bugzilla.kernel.org/show_bug.cgi?id=30802

Alan <[email protected]> changed:

What |Removed |Added
----------------------------------------------------------------------------

             Status|NEW                         |RESOLVED
                 CC|                            |[email protected]
         Resolution|                            |DOCUMENTED
Signature · 3 lines
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.