Can someone please explain these log entries?

Status
Not open for further replies.
N

NASbox

Guru
Joined
May 8, 2012
Messages
650
Can someone please explain these messages to me?
(They came as part of the first nightly email report after powering on the system when I returned from vacation. The system was powered off for about 3 weeks.)

Code:
freenas.pvt kernel log messages:
[REMOVED]
da0 at mps0 bus 0 scbus0 target 2 lun 0
da0: <ATA WDC WD60EFRX-68L 0A82> Fixed Direct Access SPC-4 SCSI device
da0: Serial Number WD-------------
da0: 600.000MB/s transfers
da0: Command Queueing enabled
da0: 5723166MB (11721045168 512 byte sectors)
da0: quirks=0x8<4K>
da2 at mps0 bus 0 scbus0 target 4 lun 0
da2: <ATA WDC WD60EFRX-68M 0A82> Fixed Direct Access SPC-4 SCSI device
da2: Serial Number WD-------------
da2: 600.000MB/s transfers
da2: Command Queueing enabled
da2: 5723166MB (11721045168 512 byte sectors)
da2: quirks=0x8<4K>
[REMOVED]
-- End of security output --

Of particular interest is why only 2 drives are reported.
The box has a total of 10 drives in it.
POOL1 has 4 drives (RAIDZ2)
POOL2 has 2 drives (RAIDZ)
and there are 4 unassigned drives that will be used when I destroy POOL1 and recreate/expand it to 8 drives RAIDZ2.
da0 is unassigned, and da2 is part of POOL1.

Does this point to some type of setting that might need to be adjusted?
[The current configuration was updated from 8.3.1 to 11.0 (Manual) and then 11.0U3/U4 (automatic).]

Thanks in advance for any insight/info.
 
Chris Moore

Chris Moore

Hall of Famer
Joined
May 2, 2015
Messages
10,080
There must be more to the log that you are not seeing because all your drives should be enumerated at boot.
If your pools are working and you can see all your drives in the GUI, there is nothing wrong.
It is just incomplete for some reason and there can be any number of reasons for that.
It could even be that the email was incomplete but if you looked at the system it would all be there.
Also, it purges after the log gets to a certain size.
Is the system giving you any problems?
 
N

NASbox

Guru
Joined
May 8, 2012
Messages
650
Chris Moore said:
There must be more to the log that you are not seeing because all your drives should be enumerated at boot.
If your pools are working and you can see all your drives in the GUI, there is nothing wrong.
It is just incomplete for some reason and there can be any number of reasons for that.
It could even be that the email was incomplete but if you looked at the system it would all be there.
Also, it purges after the log gets to a certain size.
Is the system giving you any problems?
Click to expand...
Thanks for the reply. AFAIK the box is working perfectly... I don't believe these messages are the standard messages that come near the front of the boot sequence, but were generated at a different time. There was a number of messages before and after that were unrelated to disk drives that make me think that they didn't get truncated, but that these messages indicated some sort of exception or difference with these two drives.

Again, I might be wrong about that, but the reason I asked the question was to see if I was missing something.
What is that line 'Quirks' about?
Is it possible only 2 disks have that set? I have 8 drives of the same type, so they should all be set the same.
Anything I should check?
 
Chris Moore

Chris Moore

Hall of Famer
Joined
May 2, 2015
Messages
10,080
I get that quirks=0x8<4K> notification on every one of my data drives. It is because the drive has 4K-bytes per physical sector, emulated at 512-byte sectors. I get the same notification on every drive because all my drives are the same brand and type. I suppose that if these two drives are different from all your other drives, they might be the only ones giving the notification, but it isn't an error.
Code:
Dec  8 17:17:18 My-NAS ada0 at ahcich8 bus 0 scbus10 target 0 lun 0
Dec  8 17:17:18 My-NAS ada0: <FUJITSU MHW2040BS 00000012> ATA8-ACS SATA 1.x device
Dec  8 17:17:18 My-NAS ada0: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS ada0: 150.000MB/s transfers (SATA 1.x, UDMA5, PIO 8192bytes)
Dec  8 17:17:18 My-NAS ada0: Command Queueing enabled
Dec  8 17:17:18 My-NAS ada0: 38154MB (78140160 512 byte sectors)
Dec  8 17:17:18 My-NAS ada1 at ahcich9 bus 0 scbus11 target 0 lun 0
Dec  8 17:17:18 My-NAS ada1: <FUJITSU MHW2040BS 00000012> ATA8-ACS SATA 1.x device
Dec  8 17:17:18 My-NAS ada1: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS ada1: 150.000MB/s transfers (SATA 1.x, UDMA5, PIO 8192bytes)
Dec  8 17:17:18 My-NAS ada1: Command Queueing enabled
Dec  8 17:17:18 My-NAS ada1: 38154MB (78140160 512 byte sectors)
Dec  8 17:17:18 My-NAS da2 at mps0 bus 0 scbus0 target 59 lun 0
Dec  8 17:17:18 My-NAS da2: <ATA ST4000DM000-1F21 CC54> Fixed Direct Access SPC-4 SCSI device
Dec  8 17:17:18 My-NAS da0 at mps0 bus 0 scbus0 target 18 lun 0
Dec  8 17:17:18 My-NAS da2: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS da2: 600.000MB/s transfers
Dec  8 17:17:18 My-NAS da2: Command Queueing enabled
Dec  8 17:17:18 My-NAS da0: <ATA ST2000DM001-1ER1 CC25> Fixed Direct Access SPC-4 SCSI device
Dec  8 17:17:18 My-NAS da2: 3815447MB (7814037168 512 byte sectors)
Dec  8 17:17:18 My-NAS da0: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS da0: 600.000MB/s transfers
Dec  8 17:17:18 My-NAS da2: quirks=0x8<4K>
Dec  8 17:17:18 My-NAS da1 at mps0 bus 0 scbus0 target 19 lun 0
Dec  8 17:17:18 My-NAS da0: Command Queueing enabled
Dec  8 17:17:18 My-NAS da0: 1907729MB (3907029168 512 byte sectors)
Dec  8 17:17:18 My-NAS da0: quirks=0x8<4K>
Dec  8 17:17:18 My-NAS da1: <ATA ST2000DM001-1ER1 CC25> Fixed Direct Access SPC-4 SCSI device
Dec  8 17:17:18 My-NAS da3 at mps0 bus 0 scbus0 target 60 lun 0
Dec  8 17:17:18 My-NAS da1: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS da1: 600.000MB/s transfersda3: <ATA ST4000DM000-1F21 CC54> Fixed Direct Access SPC-4 SCSI device
Dec  8 17:17:18 My-NAS da3: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS da3: 600.000MB/s transfers
Dec  8 17:17:18 My-NAS da3: Command Queueing enabled
Dec  8 17:17:18 My-NAS da1: Command Queueing enabled
Dec  8 17:17:18 My-NAS da1: 1907729MB (3907029168 512 byte sectors)
Dec  8 17:17:18 My-NAS da1: quirks=0x8<4K>
Dec  8 17:17:18 My-NAS da3: 3815447MB (7814037168 512 byte sectors)
Dec  8 17:17:18 My-NAS da3: quirks=0x8<4K>
Dec  8 17:17:18 My-NAS da5 at mps0 bus 0 scbus0 target 62 lun 0
Dec  8 17:17:18 My-NAS da4 at mps0 bus 0 scbus0 target 61 lun 0
Dec  8 17:17:18 My-NAS da4: <ATA ST4000DM000-1F21 CC54> Fixed Direct Access SPC-4 SCSI device
Dec  8 17:17:18 My-NAS da5: <ATA ST4000DM000-1F21 CC54> Fixed Direct Access SPC-4 SCSI device
Dec  8 17:17:18 My-NAS da5: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS da4: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS da5: 600.000MB/s transfers
Dec  8 17:17:18 My-NAS da5: Command Queueing enabled
Dec  8 17:17:18 My-NAS da4: 600.000MB/s transfers
Dec  8 17:17:18 My-NAS da4: Command Queueing enabled
Dec  8 17:17:18 My-NAS da4: 3815447MB (7814037168 512 byte sectors)
Dec  8 17:17:18 My-NAS da5: 3815447MB (7814037168 512 byte sectors)
Dec  8 17:17:18 My-NAS da5: quirks=0x8<4K>
Dec  8 17:17:18 My-NAS da4: quirks=0x8<4K>
Dec  8 17:17:18 My-NAS da6 at mps1 bus 0 scbus1 target 11 lun 0
Dec  8 17:17:18 My-NAS da6: <ATA ST2000DM001-1ER1 CC25> Fixed Direct Access SPC-4 SCSI device
Dec  8 17:17:18 My-NAS da7 at mps1 bus 0 scbus1 target 12 lun 0
Dec  8 17:17:18 My-NAS da6: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS da7: <ATA ST4000DM000-1F21 CC54> Fixed Direct Access SPC-4 SCSI device
Dec  8 17:17:18 My-NAS da6: 600.000MB/s transfers
Dec  8 17:17:18 My-NAS da6: Command Queueing enabled
Dec  8 17:17:18 My-NAS da6: 1907729MB (3907029168 512 byte sectors)
Dec  8 17:17:18 My-NAS da7: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS da7: 600.000MB/s transfers
Dec  8 17:17:18 My-NAS da7: Command Queueing enabled
Dec  8 17:17:18 My-NAS da6: quirks=0x8<4K>
Dec  8 17:17:18 My-NAS da8 at mps1 bus 0 scbus1 target 13 lun 0
Dec  8 17:17:18 My-NAS da7: 3815447MB (7814037168 512 byte sectors)
Dec  8 17:17:18 My-NAS da8: <ATA ST4000DM000-1F21 CC54> Fixed Direct Access SPC-4 SCSI device
Dec  8 17:17:18 My-NAS da7: quirks=0x8<4K>
Dec  8 17:17:18 My-NAS da8: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS da8: 600.000MB/s transfers
Dec  8 17:17:18 My-NAS da8: Command Queueing enabled
Dec  8 17:17:18 My-NAS da9 at mps1 bus 0 scbus1 target 14 lun 0
Dec  8 17:17:18 My-NAS da8: 3815447MB (7814037168 512 byte sectors)
Dec  8 17:17:18 My-NAS da9: da8: quirks=0x8<4K>
Dec  8 17:17:18 My-NAS syslog-ng[1799]: Error processing log message: <ATA ST2000DM001-1ER1 CC25> Fixed Direct Access SPC-4 SCSI device
Dec  8 17:17:18 My-NAS da10 at mps1 bus 0 scbus1 target 15 lun 0
Dec  8 17:17:18 My-NAS da9: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS da10: <ATA ST2000DM001-1ER1 CC25> Fixed Direct Access SPC-4 SCSI device
Dec  8 17:17:18 My-NAS da9: 600.000MB/s transfers
Dec  8 17:17:18 My-NAS da10: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS da10: 600.000MB/s transfers
Dec  8 17:17:18 My-NAS da9: Command Queueing enabled
Dec  8 17:17:18 My-NAS da9: 1907729MB (3907029168 512 byte sectors)
Dec  8 17:17:18 My-NAS da9: quirks=0x8<4K>
Dec  8 17:17:18 My-NAS da10: Command Queueing enabled
Dec  8 17:17:18 My-NAS da11 at mps1 bus 0 scbus1 target 16 lun 0
Dec  8 17:17:18 My-NAS da11: <ATA ST2000DM001-1ER1 CC25> Fixed Direct Access SPC-4 SCSI device
Dec  8 17:17:18 My-NAS da10: 1907729MB (3907029168 512 byte sectors)
Dec  8 17:17:18 My-NAS da10: quirks=0x8<4K>
Dec  8 17:17:18 My-NAS da11: Serial Number xxxxxxxxxx
Dec  8 17:17:18 My-NAS da11: 600.000MB/s transfers
Dec  8 17:17:18 My-NAS da11: Command Queueing enabled
Dec  8 17:17:18 My-NAS da11: 1907729MB (3907029168 512 byte sectors)
Dec  8 17:17:18 My-NAS da11: quirks=0x8<4K>
PS. This is exactly the order that it all appears during boot on my NAS
if you go to the console and type the command more /var/log/messages, you can get a listing of everything since the log was purged.
 
Last edited:
N

NASbox

Guru
Joined
May 8, 2012
Messages
650
Chris Moore said:
I get that quirks=0x8<4K> notification on every one of my data drives. It is because the drive has 4K-bytes per physical sector, emulated at 512-byte sectors. I get the same notification on every drive because all my drives are the same brand and type. I suppose that if these two drives are different from all your other drives, they might be the only ones giving the notification, but it isn't an error.

PS. This is exactly the order that it all appears during boot on my NAS if you go to the console and type the command more /var/log/messages, you can get a listing of everything since the log was purged.
Click to expand...
Thanks for the reply... I had a look through the log, and found entries for all 8 drives.

It's really strange that only 2 error messages showed up in the email log. In /var/log/messages, all drives are together and had the same message. Can't figure out why the email log showed only 2 ( and it wasn't truncated because there were other messages either side that I removed before posting.

The main thing is that there doesn't appear to be anything wrong, so I'll just let this one go.

Thanks again for the input.
 
Status
Not open for further replies.

Similar threads

A
  • Locked
Is this Error processing log message any real concern?
Replies
2
Views
1K
Amsoil_Jim
A
thepixelgeek
Plex GUI: "This page isn’t working" / Need help troubleshooting
Replies
0
Views
719
thepixelgeek
thepixelgeek
R
Help with following error: kernel log messages: SMP: AP CPU #3 Launched!
Replies
3
Views
742
Chris Moore
Chris Moore
STREBLO
  • Locked
Security Output
Replies
3
Views
1K
STREBLO
STREBLO
A
FreeNAS Crashing on Fresh Install
Replies
2
Views
2K
subhuman
S
Top