Help with Security Run Output

[djdwosk97]

I received an email this morning from my server with a security run output, but I'm not sure what it actually means. Any help?

Code:

freenas.local kernel log messages:
> ahcich1: Timeout on slot 28 port 0
> ahcich1: is 00000000 cs 10000000 ss 00000000 rs 10000000 tfd c0 serr 00000000 cmd 0004dc17
> (ada1:ahcich1:0:0:0): FLUSHCACHE48. ACB: ea 00 00 00 00 40 00 00 00 00 00 00
> (ada1:ahcich1:0:0:0): CAM status: Command timeout
> (ada1:ahcich1:0:0:0): Retrying command
> ahcich1: AHCI reset: device not ready after 31000ms (tfd = 00000080)
> ahcich1: Timeout on slot 28 port 0
> ahcich1: is 00000000 cs 10000000 ss 00000000 rs 10000000 tfd 80 serr 00000000 cmd 0004dc17
> (aprobe0:ahcich1:0:0:0): ATA_IDENTIFY. ACB: ec 00 00 00 00 40 00 00 00 00 00 00
> (aprobe0:ahcich1:0:0:0): CAM status: Command timeout
> (aprobe0:ahcich1:0:0:0): Error 5, Retry was blocked
> ahcich1: AHCI reset: device not ready after 31000ms (tfd = 00000080)

-- End of security output --

 

[DrKK]

Looks like a failing hard drive, or other problem with the hard drive. Do you not have smartd configured to email you? Please let us see the output of

Code:

smartctl -x /dev/ada1

either here in "code" tags, or on pastebin. Thanks.

 

[djdwosk97]

Looks like a failing hard drive, or other problem with the hard drive. Do you not have smartd configured to email you? Please let us see the output of

Code:

smartctl -x /dev/ada1

either here in "code" tags, or on pastebin. Thanks.

https://forums.freenas.org/index.php?threads/possible-drive-failure-in-progress.41349/#post-264844
Like you pointed out in the other thread, there is a high raw read error rate,

Code:

smartctl 6.3 2014-07-26 r3976 [FreeBSD 9.3-RELEASE-p13 amd64] (local build)
Copyright (C) 2002-14, Bruce Allen, Christian Franke, www.smartmontools.org

=== START OF INFORMATION SECTION ===
Model Family: Seagate Barracuda 7200.12
Device Model: ST31000528AS
Serial Number: 5VP253Z9
LU WWN Device Id: 5 000c50 01c4ee5d6
Firmware Version: CC38
User Capacity: 1,000,204,886,016 bytes [1.00 TB]
Sector Size: 512 bytes logical/physical
Rotation Rate: 7200 rpm
Device is: In smartctl database [for details use: -P show]
ATA Version is: ATA8-ACS T13/1699-D revision 4
SATA Version is: SATA 2.6, 3.0 Gb/s
Local Time is: Tue Feb 16 07:24:54 2016 EST

==> WARNING: A firmware update for this drive may be available,
see the following Seagate web pages:
http://knowledge.seagate.com/articles/en_US/FAQ/207931en
http://knowledge.seagate.com/articles/en_US/FAQ/213891en

SMART support is: Available - device has SMART capability.
SMART support is: Enabled
AAM feature is: Disabled
APM feature is: Unavailable
Rd look-ahead is: Enabled
Write cache is: Enabled
ATA Security is: Disabled, frozen [SEC2]
Wt Cache Reorder: Unknown

=== START OF READ SMART DATA SECTION ===
SMART overall-health self-assessment test result: PASSED
See vendor-specific Attribute list for marginal Attributes.

General SMART Values:
Offline data collection status: (0x82) Offline data collection activity
was completed without error.
Auto Offline Data Collection: Enabled.
Self-test execution status: ( 0) The previous self-test routine completed
without error or no self-test has ever
been run.
Total time to complete Offline
data collection: ( 609) seconds.
Offline data collection
capabilities: (0x7b) SMART execute Offline immediate.
Auto Offline data collection on/off support.
Suspend Offline collection upon new
command.
Offline surface scan supported.
Self-test supported.
Conveyance Self-test supported.
Selective Self-test supported.
SMART capabilities: (0x0003) Saves SMART data before entering
power-saving mode.
Supports SMART auto save timer.
Error logging capability: (0x01) Error logging supported.
General Purpose Logging supported.
Short self-test routine
recommended polling time: ( 1) minutes.
Extended self-test routine
recommended polling time: ( 184) minutes.
Conveyance self-test routine
recommended polling time: ( 2) minutes.
SCT capabilities: (0x103f) SCT Status supported.
SCT Error Recovery Control supported.
SCT Feature Control supported.
SCT Data Table supported.
SMART Attributes Data Structure revision number: 10
Vendor Specific SMART Attributes with Thresholds:
ID# ATTRIBUTE_NAME FLAGS VALUE WORST THRESH FAIL RAW_VALUE
1 Raw_Read_Error_Rate POSR-- 118 099 006 - 180119017
3 Spin_Up_Time PO---- 095 094 000 - 0
4 Start_Stop_Count -O--CK 100 100 020 - 595
5 Reallocated_Sector_Ct PO--CK 100 100 036 - 0
7 Seek_Error_Rate POSR-- 061 055 030 - 107403824406
9 Power_On_Hours -O--CK 090 090 000 - 9166
10 Spin_Retry_Count PO--C- 100 100 097 - 0
12 Power_Cycle_Count -O--CK 100 100 020 - 131
183 Runtime_Bad_Block -O--CK 100 100 000 - 0
184 End-to-End_Error -O--CK 100 100 099 - 0
187 Reported_Uncorrect -O--CK 100 100 000 - 0
188 Command_Timeout -O--CK 100 099 000 - 55835426829
189 High_Fly_Writes -O-RCK 098 098 000 - 2
190 Airflow_Temperature_Cel -O---K 073 043 045 Past 27 (0 5 34 23 0)
194 Temperature_Celsius -O---K 027 057 000 - 27 (0 15 0 0 0)
195 Hardware_ECC_Recovered -O-RC- 040 024 000 - 180119017
197 Current_Pending_Sector -O--C- 100 100 000 - 0
198 Offline_Uncorrectable ----C- 100 100 000 - 0
199 UDMA_CRC_Error_Count -OSRCK 200 200 000 - 0
240 Head_Flying_Hours ------ 100 253 000 - 6042 (211 27 0)
241 Total_LBAs_Written ------ 100 253 000 - 1524329561
242 Total_LBAs_Read ------ 100 253 000 - 181009027
||||||_ K auto-keep
|||||__ C event count
||||___ R error rate
|||____ S speed/performance
||_____ O updated online
|______ P prefailure warning
General Purpose Log Directory Version 1
SMART Log Directory Version 1 [multi-sector log support]
Address Access R/W Size Description
0x00 GPL,SL R/O 1 Log Directory
0x01 GPL,SL R/O 1 Summary SMART error log
0x02 GPL,SL R/O 5 Comprehensive SMART error log
0x03 GPL R/O 5 Ext. Comprehensive SMART error log
0x06 GPL,SL R/O 1 SMART self-test log
0x07 GPL R/O 1 Extended self-test log
0x09 GPL,SL R/W 1 Selective self-test log
0x10 GPL R/O 1 NCQ Command Error log
0x11 GPL R/O 1 SATA Phy Event Counters
0x21 GPL R/O 1 Write stream error log
0x22 GPL R/O 1 Read stream error log
0x80-0x9f GPL,SL R/W 16 Host vendor specific log
0xa1 GPL,SL VS 20 Device vendor specific log
0xa2 GPL VS 2248 Device vendor specific log
0xa8 GPL,SL VS 129 Device vendor specific log
0xa9 GPL,SL VS 1 Device vendor specific log
0xb0 GPL VS 2928 Device vendor specific log
0xbd GPL VS 252 Device vendor specific log
0xbe-0xbf GPL VS 65535 Device vendor specific log
0xc0 GPL,SL VS 1 Device vendor specific log
0xe0 GPL,SL R/W 1 SCT Command/Status
0xe1 GPL,SL R/W 1 SCT Data Transfer

SMART Extended Comprehensive Error Log Version: 1 (5 sectors)
No Errors Logged
SMART Extended Self-test Log Version: 1 (1 sectors)
Num Test_Description Status Remaining LifeTime(hours) LBA_of_first_error
# 1 Short offline Completed without error 00% 9065 -
# 2 Extended offline Completed without error 00% 8973 -
# 3 Short offline Completed without error 00% 8897 -
# 4 Extended offline Completed without error 00% 8697 -
# 5 Short offline Completed without error 00% 8622 -
# 6 Short offline Completed without error 00% 8454 -
# 7 Extended offline Completed without error 00% 8362 -
# 8 Short offline Completed without error 00% 8286 -
# 9 Extended offline Completed without error 00% 8121 -
#10 Extended offline Completed without error 00% 7954 -
#11 Extended offline Completed without error 00% 7786 -
#12 Extended offline Completed without error 00% 7618 -
#13 Extended offline Completed without error 00% 7449 -
#14 Extended offline Completed without error 00% 7401 -
#15 Extended offline Completed without error 00% 7233 -
#16 Extended offline Completed without error 00% 7065 -
#17 Extended offline Interrupted (host reset) 00% 6897 -
#18 Extended offline Completed without error 00% 6729 -
#19 Extended offline Completed without error 00% 6656 -

SMART Selective self-test log data structure revision number 1
SPAN MIN_LBA MAX_LBA CURRENT_TEST_STATUS
1 0 0 Not_testing
2 0 0 Not_testing
3 0 0 Not_testing
4 0 0 Not_testing
5 0 0 Not_testing
Selective self-test flags (0x0):
After scanning selected spans, do NOT read-scan remainder of disk.
If Selective self-test is pending on power-up, resume after 0 minute delay.

SCT Status Version: 3
SCT Version (vendor specific): 522 (0x020a)
SCT Support Level: 1
Device State: Active (0)
Current Temperature: 27 Celsius
Power Cycle Min/Max Temperature: 23/34 Celsius
Lifetime Min/Max Temperature: 15/57 Celsius
Under/Over Temperature Limit Count: 0/0

SCT Temperature History Version: 2
Temperature Sampling Period: 1 minute
Temperature Logging Interval: 59 minutes
Min/Max recommended Temperature: 14/55 Celsius
Min/Max Temperature Limit: 10/60 Celsius
Temperature History Size (Index): 128 (41)

Index Estimated Time Temperature Celsius
42 2016-02-11 01:54 27 ********
... ..( 2 skipped). .. ********
45 2016-02-11 04:51 27 ********
46 2016-02-11 05:50 26 *******
47 2016-02-11 06:49 26 *******
48 2016-02-11 07:48 25 ******
... ..( 8 skipped). .. ******
57 2016-02-11 16:39 25 ******
58 2016-02-11 17:38 24 *****
59 2016-02-11 18:37 24 *****
60 2016-02-11 19:36 28 *********
61 2016-02-11 20:35 29 **********
62 2016-02-11 21:34 30 ***********
... ..( 2 skipped). .. ***********
65 2016-02-12 00:31 30 ***********
66 2016-02-12 01:30 29 **********
67 2016-02-12 02:29 28 *********
68 2016-02-12 03:28 27 ********
69 2016-02-12 04:27 26 *******
70 2016-02-12 05:26 25 ******
71 2016-02-12 06:25 25 ******
72 2016-02-12 07:24 24 *****
73 2016-02-12 08:23 24 *****
74 2016-02-12 09:22 23 ****
... ..( 2 skipped). .. ****
77 2016-02-12 12:19 23 ****
78 2016-02-12 13:18 24 *****
79 2016-02-12 14:17 28 *********
80 2016-02-12 15:16 29 **********
... ..( 3 skipped). .. **********
84 2016-02-12 19:12 29 **********
85 2016-02-12 20:11 30 ***********
86 2016-02-12 21:10 28 *********
87 2016-02-12 22:09 27 ********
88 2016-02-12 23:08 28 *********
89 2016-02-13 00:07 29 **********
90 2016-02-13 01:06 28 *********
91 2016-02-13 02:05 27 ********
92 2016-02-13 03:04 26 *******
93 2016-02-13 04:03 26 *******
94 2016-02-13 05:02 25 ******
95 2016-02-13 06:01 25 ******
96 2016-02-13 07:00 25 ******
97 2016-02-13 07:59 24 *****
98 2016-02-13 08:58 24 *****
99 2016-02-13 09:57 24 *****
100 2016-02-13 10:56 26 *******
101 2016-02-13 11:55 29 **********
102 2016-02-13 12:54 28 *********
103 2016-02-13 13:53 30 ***********
104 2016-02-13 14:52 28 *********
105 2016-02-13 15:51 27 ********
106 2016-02-13 16:50 27 ********
107 2016-02-13 17:49 28 *********
108 2016-02-13 18:48 30 ***********
109 2016-02-13 19:47 31 ************
110 2016-02-13 20:46 31 ************
111 2016-02-13 21:45 32 *************
112 2016-02-13 22:44 33 **************
113 2016-02-13 23:43 33 **************
114 2016-02-14 00:42 30 ***********
115 2016-02-14 01:41 28 *********
116 2016-02-14 02:40 27 ********
117 2016-02-14 03:39 26 *******
118 2016-02-14 04:38 26 *******
119 2016-02-14 05:37 25 ******
120 2016-02-14 06:36 24 *****
121 2016-02-14 07:35 24 *****
122 2016-02-14 08:34 23 ****
123 2016-02-14 09:33 26 *******
124 2016-02-14 10:32 29 **********
125 2016-02-14 11:31 29 **********
126 2016-02-14 12:30 30 ***********
127 2016-02-14 13:29 31 ************
0 2016-02-14 14:28 32 *************
1 2016-02-14 15:27 33 **************
2 2016-02-14 16:26 31 ************
3 2016-02-14 17:25 32 *************
4 2016-02-14 18:24 30 ***********
5 2016-02-14 19:23 32 *************
6 2016-02-14 20:22 32 *************
7 2016-02-14 21:21 33 **************
8 2016-02-14 22:20 34 ***************
9 2016-02-14 23:19 34 ***************
10 2016-02-15 00:18 34 ***************
11 2016-02-15 01:17 30 ***********
12 2016-02-15 02:16 29 **********
13 2016-02-15 03:15 28 *********
14 2016-02-15 04:14 27 ********
15 2016-02-15 05:13 26 *******
16 2016-02-15 06:12 26 *******
17 2016-02-15 07:11 25 ******
18 2016-02-15 08:10 26 *******
19 2016-02-15 09:09 25 ******
20 2016-02-15 10:08 25 ******
21 2016-02-15 11:07 24 *****
22 2016-02-15 12:06 24 *****
23 2016-02-15 13:05 23 ****
24 2016-02-15 14:04 23 ****
25 2016-02-15 15:03 23 ****
26 2016-02-15 16:02 27 ********
27 2016-02-15 17:01 28 *********
28 2016-02-15 18:00 29 **********
29 2016-02-15 18:59 30 ***********
30 2016-02-15 19:58 31 ************
31 2016-02-15 20:57 32 *************
32 2016-02-15 21:56 32 *************
33 2016-02-15 22:55 33 **************
34 2016-02-15 23:54 31 ************
35 2016-02-16 00:53 30 ***********
36 2016-02-16 01:52 29 **********
37 2016-02-16 02:51 29 **********
38 2016-02-16 03:50 28 *********
39 2016-02-16 04:49 28 *********
40 2016-02-16 05:48 27 ********
41 2016-02-16 06:47 27 ********

SCT Error Recovery Control:
Read: Disabled
Write: Disabled

Device Statistics (GP Log 0x04) not supported

SATA Phy Event Counters (GP Log 0x11)
ID Size Value Description
0x000a 2 13 Device-to-host register FISes sent due to a COMRESET
0x0001 2 0 Command failed due to ICRC error
0x0003 2 0 R_ERR response for device-to-host data FIS
0x0004 2 0 R_ERR response for host-to-device data FIS
0x0006 2 0 R_ERR response for device-to-host non-data FIS
0x0007 2 0 R_ERR response for host-to-device non-data FIS

(END)

 

[djdwosk97]

-- accidentally double posted, repurposed --

I thought I setup SMART tests to email me.

 

[DrKK]

I don't know what to tell you. You are now on multiple threads where you have drive problems, and these *are* Shitgate Barracrappa drives.

I think the universe is trying to tell you something.

 

[djdwosk97]

I don't know what to tell you. You are now on multiple threads where you have drive problems, and these *are* Shitgate Barracrappa drives.

I think the universe is trying to tell you something.

Wouldn't the SMART test be failing an notifying me if the drive was failing? The high error rates don't look good, but there haven't been any relocated sectors nor is it saying the drive failed.

 

[DrKK]

Wouldn't the SMART test be failing an notifying me if the drive was failing? The high error rates don't look good, but there haven't been any relocated sectors nor is it saying the drive failed.

Look.

Code:

[*]> ahcich1: Timeout on slot 28 port 0
[*]> ahcich1: is 00000000 cs 10000000 ss 00000000 rs 10000000 tfd c0 serr 00000000 cmd 0004dc17
[*]> (ada1:ahcich1:0:0:0): FLUSHCACHE48. ACB: ea 00 00 00 00 40 00 00 00 00 00 00
[*]> (ada1:ahcich1:0:0:0): CAM status: Command timeout
[*]> (ada1:ahcich1:0:0:0): Retrying command
[*]> ahcich1: AHCI reset: device not ready after 31000ms (tfd = 00000080)
[*]> ahcich1: Timeout on slot 28 port 0
[*]> ahcich1: is 00000000 cs 10000000 ss 00000000 rs 10000000 tfd 80 serr 00000000 cmd 0004dc17
[*]> (aprobe0:ahcich1:0:0:0): ATA_IDENTIFY. ACB: ec 00 00 00 00 40 00 00 00 00 00 00
[*]> (aprobe0:ahcich1:0:0:0): CAM status: Command timeout
[*]> (aprobe0:ahcich1:0:0:0): Error 5, Retry was blocked
[*]> ahcich1: AHCI reset: device not ready after 31000ms (tfd = 00000080)

Command timeouts on the drive are bad. AHCI resets are bad. You have a notoriously horrible drive model. Not all failure modes can be picked up by SMART tests. Your drive has been as hot as 57C---most of us would take a drive that ever got beyond 45C-50C for even one second, and would throw it in the garbage can. Even if this drive wasn't generating CAM errors, *I* would be throwing it in the garbage.


I don't know what else you want me to tell you.