Hard drive status "ejected"

Questions about SNMP, Power, System, Logs, disk, & RAID.
Post Reply
chuahyen
Starting out
Posts: 20
Joined: Mon Aug 27, 2012 11:21 am

Hard drive status "ejected"

Post by chuahyen »

My NAS 469Pro, 4 disks raid were running fine until one day HDD3 and HDD4 were ejected for no reason.
Then the RAID 10 failed.
I cloned the 2 disks onto newer disks and still have the same problem.
I tried to go into command line to use
md_checker
mdadm -CfR
init_lvm.sh

but it doesn't seem to work
please help

regards
chris
chuahyen
Starting out
Posts: 20
Joined: Mon Aug 27, 2012 11:21 am

Re: Hard drive status "ejected"

Post by chuahyen »

when I type dmesg command, the out put is this
Something wrong with the NAS hardware?
======= start ==============
[ 944.731161] RAID1 conf printout:
[ 944.731167] --- wd:3 rd:4
[ 944.731172] disk 0, wo:0, o:1, dev:sdb1
[ 944.731176] disk 1, wo:1, o:0, dev:sdc1
[ 944.731180] disk 2, wo:0, o:1, dev:sda1
[ 944.731184] disk 3, wo:0, o:1, dev:sdd1
[ 944.736018] RAID1 conf printout:
[ 944.736022] --- wd:3 rd:4
[ 944.736026] disk 0, wo:0, o:1, dev:sdb1
[ 944.736029] disk 2, wo:0, o:1, dev:sda1
[ 944.736033] disk 3, wo:0, o:1, dev:sdd1
[ 945.693777] md: unbind<sdc1>
[ 945.700024] md: export_rdev(sdc1)
[ 960.005417] md: bind<sdc1>
[ 960.046163] RAID1 conf printout:
[ 960.046171] --- wd:3 rd:4
[ 960.046177] disk 0, wo:0, o:1, dev:sdb1
[ 960.046182] disk 1, wo:1, o:1, dev:sdc1
[ 960.046187] disk 2, wo:0, o:1, dev:sda1
[ 960.046192] disk 3, wo:0, o:1, dev:sdd1
[ 960.046285] md: recovery of RAID array md9
[ 960.046291] md: minimum _guaranteed_ speed: 5000 KB/sec/disk.
[ 960.046295] md: using maximum available idle IO bandwidth (but not more than 200000 KB/sec) for recovery.
[ 960.046299] md: Recovering started: md9
[ 960.046311] md: using 128k window, over a total of 530048k.
[ 960.500903] md: md9: recovery done.
[ 960.500910] md: Recovering done: md9, degraded=1
[ 960.539824] RAID1 conf printout:
[ 960.539832] --- wd:4 rd:4
[ 960.539838] disk 0, wo:0, o:1, dev:sdb1
[ 960.539842] disk 1, wo:0, o:1, dev:sdc1
[ 960.539846] disk 2, wo:0, o:1, dev:sda1
[ 960.539850] disk 3, wo:0, o:1, dev:sdd1
[ 962.102140] md/raid1:md9: Disk failure on sdd1, disabling device.
[ 962.102143] md/raid1:md9: Operation continuing on 3 devices.
[ 962.156001] RAID1 conf printout:
[ 962.156023] --- wd:3 rd:4
[ 962.156031] disk 0, wo:0, o:1, dev:sdb1
[ 962.156036] disk 1, wo:0, o:1, dev:sdc1
[ 962.156039] disk 2, wo:0, o:1, dev:sda1
[ 962.156043] disk 3, wo:1, o:0, dev:sdd1
[ 962.161014] RAID1 conf printout:
[ 962.161017] --- wd:3 rd:4
[ 962.161021] disk 0, wo:0, o:1, dev:sdb1
[ 962.161025] disk 1, wo:0, o:1, dev:sdc1
[ 962.161028] disk 2, wo:0, o:1, dev:sda1
[ 963.114980] md: unbind<sdd1>
[ 963.119025] md: export_rdev(sdd1)
[ 977.390434] md: bind<sdd1>
[ 977.436333] RAID1 conf printout:
[ 977.436340] --- wd:3 rd:4
[ 977.436346] disk 0, wo:0, o:1, dev:sdb1
[ 977.436350] disk 1, wo:0, o:1, dev:sdc1
[ 977.436353] disk 2, wo:0, o:1, dev:sda1
[ 977.436357] disk 3, wo:1, o:1, dev:sdd1
[ 977.436513] md: recovery of RAID array md9
[ 977.436519] md: minimum _guaranteed_ speed: 5000 KB/sec/disk.
[ 977.436525] md: using maximum available idle IO bandwidth (but not more than 200000 KB/sec) for recovery.
[ 977.436531] md: Recovering started: md9
[ 977.436547] md: using 128k window, over a total of 530048k.
[ 977.781610] md: md9: recovery done.
[ 977.781617] md: Recovering done: md9, degraded=1
[ 977.844456] RAID1 conf printout:
[ 977.844463] --- wd:4 rd:4
[ 977.844469] disk 0, wo:0, o:1, dev:sdb1
[ 977.844473] disk 1, wo:0, o:1, dev:sdc1
[ 977.844476] disk 2, wo:0, o:1, dev:sda1
[ 977.844480] disk 3, wo:0, o:1, dev:sdd1
[ 2473.908875] ata10.00: exception Emask 0x52 SAct 0x0 SErr 0xffffffff action 0xe frozen
[ 2473.908885] ata10: SError: { RecovData RecovComm UnrecovData Persist Proto HostInt PHYRdyChg PHYInt CommWake 10B8B Dispar BadCRC Handshk LinkSeq TrStaTrns UnrecFIS DevExch }
[ 2473.908894] ata10.00: failed command: IDENTIFY DEVICE
[ 2473.908905] ata10.00: cmd ec/00:00:00:00:00/00:00:00:00:00/00 tag 0 pio 512 in
[ 2473.908907] res 40/00:01:00:4f:c2/00:00:00:00:00/00 Emask 0x56 (ATA bus error)
[ 2473.908912] ata10.00: status: { DRDY }
[ 2473.908922] ata10: hard resetting link
[ 2475.415835] ata10: failed to resume link (SControl FFFFFFFF)
[ 2475.415861] ata10: SATA link down (SStatus FFFFFFFF SControl FFFFFFFF)
[ 2480.415837] ata10: hard resetting link
[ 2481.922837] ata10: failed to resume link (SControl FFFFFFFF)
[ 2481.922862] ata10: SATA link down (SStatus FFFFFFFF SControl FFFFFFFF)
[ 2481.922880] ata10: limiting SATA link speed to 3.0 Gbps
[ 2486.922839] ata10: hard resetting link
[ 2488.429839] ata10: failed to resume link (SControl FFFFFFFF)
[ 2488.429865] ata10: SATA link down (SStatus FFFFFFFF SControl FFFFFFFF)
[ 2488.429881] ata10.00: disabled
[ 2488.929882] sd 9:0:0:0: rejecting I/O to offline device
[ 2488.929893] sd 9:0:0:0: [sdd] killing request
[ 2488.929910] ata10: EH complete
[ 2488.929934] sd 9:0:0:0: rejecting I/O to offline device
[ 2488.929946] md: super_written gets error=-5, uptodate=0
[ 2488.929955] md/raid1:md9: Disk failure on sdd1, disabling device.
[ 2488.929957] md/raid1:md9: Operation continuing on 3 devices.
[ 2488.929985] ata10.00: detaching (SCSI 9:0:0:0)
[ 2488.933884] sd 9:0:0:0: [sdd] Synchronizing SCSI cache
[ 2488.933979] sd 9:0:0:0: [sdd] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK
[ 2488.933990] sd 9:0:0:0: [sdd] Stopping disk
[ 2488.934015] sd 9:0:0:0: [sdd] START_STOP FAILED
[ 2488.934021] sd 9:0:0:0: [sdd] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK
[ 2540.852842] ata9.00: exception Emask 0x52 SAct 0x0 SErr 0xffffffff action 0xe frozen
[ 2540.852851] ata9: SError: { RecovData RecovComm UnrecovData Persist Proto HostInt PHYRdyChg PHYInt CommWake 10B8B Dispar BadCRC Handshk LinkSeq TrStaTrns UnrecFIS DevExch }
[ 2540.852858] ata9.00: failed command: FLUSH CACHE EXT
[ 2540.852868] ata9.00: cmd ea/00:00:00:00:00/00:00:00:00:00/a0 tag 0
[ 2540.852870] res 40/00:00:00:4f:c2/00:00:00:00:00/00 Emask 0x56 (ATA bus error)
[ 2540.852875] ata9.00: status: { DRDY }
[ 2540.852884] ata9: hard resetting link
[ 2542.359832] ata9: failed to resume link (SControl FFFFFFFF)
[ 2542.359858] ata9: SATA link down (SStatus FFFFFFFF SControl FFFFFFFF)
[ 2547.359835] ata9: hard resetting link
[ 2548.866829] ata9: failed to resume link (SControl FFFFFFFF)
[ 2548.866855] ata9: SATA link down (SStatus FFFFFFFF SControl FFFFFFFF)
[ 2548.866873] ata9: limiting SATA link speed to 3.0 Gbps
[ 2553.866834] ata9: hard resetting link
[ 2555.373827] ata9: failed to resume link (SControl FFFFFFFF)
[ 2555.373853] ata9: SATA link down (SStatus FFFFFFFF SControl FFFFFFFF)
[ 2555.373869] ata9.00: disabled
[ 2555.373881] ata9.00: device reported invalid CHS sector 0
[ 2555.873837] sd 8:0:0:0: rejecting I/O to offline device
[ 2555.873848] md: super_written gets error=-5, uptodate=0
[ 2555.873855] md/raid1:md9: Disk failure on sdc1, disabling device.
[ 2555.873857] md/raid1:md9: Operation continuing on 2 devices.
[ 2555.873880] sd 8:0:0:0: rejecting I/O to offline device
[ 2555.873888] sd 8:0:0:0: [sg2] killing request
[ 2555.873899] ata9: EH complete
[ 2555.875125] ata9.00: detaching (SCSI 8:0:0:0)
[ 2555.878100] sd 8:0:0:0: [sdc] Synchronizing SCSI cache
[ 2555.878193] sd 8:0:0:0: [sdc] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK
[ 2555.878205] sd 8:0:0:0: [sdc] Stopping disk
[ 2555.878230] sd 8:0:0:0: [sdc] START_STOP FAILED
[ 2555.878238] sd 8:0:0:0: [sdc] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK
[ 2555.950409] RAID1 conf printout:
[ 2555.950417] --- wd:2 rd:4
[ 2555.950424] disk 0, wo:0, o:1, dev:sdb1
[ 2555.950428] disk 1, wo:1, o:0, dev:sdc1
[ 2555.950432] disk 2, wo:0, o:1, dev:sda1
[ 2555.950436] disk 3, wo:1, o:0, dev:sdd1
[ 2555.955810] RAID1 conf printout:
[ 2555.955813] --- wd:2 rd:4
[ 2555.955817] disk 0, wo:0, o:1, dev:sdb1
[ 2555.955821] disk 1, wo:1, o:0, dev:sdc1
[ 2555.955824] disk 2, wo:0, o:1, dev:sda1
[ 2555.955832] RAID1 conf printout:
[ 2555.955835] --- wd:2 rd:4
[ 2555.955838] disk 0, wo:0, o:1, dev:sdb1
[ 2555.955842] disk 1, wo:1, o:0, dev:sdc1
[ 2555.955846] disk 2, wo:0, o:1, dev:sda1
[ 2555.962815] RAID1 conf printout:
[ 2555.962819] --- wd:2 rd:4
[ 2555.962823] disk 0, wo:0, o:1, dev:sdb1
[ 2555.962826] disk 2, wo:0, o:1, dev:sda1
[ 2559.217182] md: unbind<sdd1>
[ 2559.222841] md: export_rdev(sdd1)
[ 2559.269938] md: unbind<sdc1>
[ 2559.278819] md: export_rdev(sdc1)
[ 2563.347840] md: cannot remove active disk sdd3 from md0 ...
[ 2564.371688] md/raid10:md0: Disk failure on sdc3, disabling device.
[ 2564.371691] md/raid10:md0: Operation continuing on 3 devices.
[ 2564.371764] md: super_written gets error=-19, uptodate=0
[ 2564.371775] md/raid10:md0: Disk failure on sdd3, disabling device.
[ 2564.371777] md/raid10:md0: Operation continuing on 2 devices.
[ 2564.464741] RAID10 conf printout:
[ 2564.464747] --- wd:2 rd:4
[ 2564.464753] disk 0, wo:0, o:1, dev:sda3
[ 2564.464757] disk 1, wo:0, o:1, dev:sdb3
[ 2564.464761] disk 2, wo:1, o:0, dev:sdc3
[ 2564.464764] disk 3, wo:1, o:0, dev:sdd3
[ 2564.469812] RAID10 conf printout:
[ 2564.469817] --- wd:2 rd:4
[ 2564.469820] disk 0, wo:0, o:1, dev:sda3
[ 2564.469824] disk 1, wo:0, o:1, dev:sdb3
[ 2564.469828] disk 2, wo:1, o:0, dev:sdc3
[ 2564.469836] RAID10 conf printout:
[ 2564.469839] --- wd:2 rd:4
[ 2564.469843] disk 0, wo:0, o:1, dev:sda3
[ 2564.469846] disk 1, wo:0, o:1, dev:sdb3
[ 2564.469850] disk 2, wo:1, o:0, dev:sdc3
[ 2564.477809] RAID10 conf printout:
[ 2564.477812] --- wd:2 rd:4
[ 2564.477816] disk 0, wo:0, o:1, dev:sda3
[ 2564.477819] disk 1, wo:0, o:1, dev:sdb3
[ 2564.542696] md: unbind<sdc3>
[ 2564.547817] md: export_rdev(sdc3)
[ 2564.616235] md: unbind<sdd3>
[ 2564.629817] md: export_rdev(sdd3)
[ 2575.273156] md0: detected capacity change from 1086193664 to 0
[ 2575.273170] md: md0 stopped.
[ 2575.273178] md: unbind<sda3>
[ 2575.283822] md: export_rdev(sda3)
[ 2575.283893] md: unbind<sdb3>
[ 2575.290812] md: export_rdev(sdb3)
[27055.150711] irq 18: nobody cared (try booting with the "irqpoll" option)
[27055.150719] Pid: 0, comm: swapper/3 Tainted: P O 3.4.6 #1
[27055.150723] Call Trace:
[27055.150726] <IRQ> [<ffffffff810aa0cb>] __report_bad_irq+0x2b/0xd0
[27055.150742] [<ffffffff810aa42a>] note_interrupt+0x1fa/0x240
[27055.150748] [<ffffffff810a7fe6>] handle_irq_event_percpu+0xd6/0x160
[27055.150754] [<ffffffff810850f7>] ? update_ts_time_stats+0x57/0x90
[27055.150759] [<ffffffff810a80a6>] handle_irq_event+0x36/0x60
[27055.150765] [<ffffffff810aae98>] handle_fasteoi_irq+0x58/0x110
[27055.150771] [<ffffffff810040ce>] handle_irq+0x1e/0x40
[27055.150776] [<ffffffff81003d76>] do_IRQ+0x46/0xc0
[27055.150782] [<ffffffff8168ace7>] common_interrupt+0x67/0x67
[27055.150785] <EOI> [<ffffffff8100a0fd>] ? mwait_idle+0x5d/0x90
[27055.150795] [<ffffffff8100aab9>] cpu_idle+0xa9/0xe0
[27055.150801] [<ffffffff8167f7bd>] start_secondary+0x1fb/0x1fd
[27055.150805] handlers:
[27055.150810] [<ffffffff8143fc80>] usb_hcd_irq
[27055.150814] [<ffffffff8143fc80>] usb_hcd_irq
[27055.150818] [<ffffffff8143fc80>] usb_hcd_irq
[27055.150821] Disabling IRQ #18
[79793.353172] e1000e: eth1 NIC Link is Down
[79793.864010] bonding: bond0: link status definitely down for interface eth1, disabling it
[80979.241360] process `sysctl' is using deprecated sysctl (syscall) net.ipv6.neigh.bond0.base_reachable_time; Use net.ipv6.neigh.bond0.base_reachable_time_ms instead.
[80979.244528] sysctl: The scan_unevictable_pages sysctl/node-interface has been disabled for lack of a legitimate use case. If you have one, please send an email to linux-mm@kvack.org.

===== End ==================
User avatar
OneCD
Guru
Posts: 12143
Joined: Sun Aug 21, 2016 10:48 am
Location: "... there, behind that sofa!"

Re: Hard drive status "ejected"

Post by OneCD »

* topic split from viewtopic.php?f=25&t=152476 *

ImageImageImageImageImageImageImageImageImageImageImageImageImageImageImageImageImageImage
Post Reply

Return to “System & Disk Volume Management”