devd confused by virtual devices.

[Paul van der Zwan]

Hi,
I just upgraded my AsrockRack C2550 based system from 9.3. to 9.10.
Installed 9.10 on new UDB stick and loaded my config and all seems well.
Except for the following messages in my logs every 3 seconds:
Oct 7 16:41:18 <user.info> 192.168.178.12 Oct 7 16:41:18 freenas devd: Processing event '<notify><system>CAM</system><subsystem>periph</subsystem><type>error</type><notify>device=cd0 serial=&#x22;AAAABBBBCCCC1&#x22; cam_status=&#x22;0xcc&#x22; scsi_status=2 scsi_sense=&#x22;70 02 3a 00&#x22; CDB=&#x22;00 00 00 00 00 00 &#x22; </notify></notify> '
Oct 7 16:41:18 <user.info> 192.168.178.12 Oct 7 16:41:18 freenas devd: Processing event '<notify><system>CAM</system><subsystem>periph</subsystem><type>error</type><notify>device=da1 serial=&#x22;AAAABBBBCCCC2&#x22; cam_status=&#x22;0xcc&#x22; scsi_status=2 scsi_sense=&#x22;70 02 3a 00&#x22; CDB=&#x22;00 00 00 00 00 00 &#x22; </notify></notify> '
Oct 7 16:41:18 <user.info> 192.168.178.12 Oct 7 16:41:18 freenas devd: Processing event '<notify><system>CAM</system><subsystem>periph</subsystem><type>error</type><notify>device=da2 serial=&#x22;AAAABBBBCCCC3&#x22; cam_status=&#x22;0xcc&#x22; scsi_status=2 scsi_sense=&#x22;70 02 3a 00&#x22; CDB=&#x22;00 00 00 00 00 00 &#x22; </notify></notify> '
Oct 7 16:41:18 <user.info> 192.168.178.12 Oct 7 16:41:18 freenas devd: Processing event '<notify><system>CAM</system><subsystem>periph</subsystem><type>error</type><notify>device=da3 serial=&#x22;AAAABBBBCCCC3&#x22; cam_status=&#x22;0xcc&#x22; scsi_status=2 scsi_sense=&#x22;70 02 3a 00&#x22; CDB=&#x22;00 20 00 00 00 00 &#x22; </notify></notify>

These messages seem to be related to the virtual disks the SP presents to the OS, which appear to have no media present.
da1 at umass-sim2 bus 2 scbus19 target 0 lun 0
da1: <AMI Virtual Floppy0 1.00> Removable Direct Access SCSI device
da1: Serial Number AAAABBBBCCCC2
da1: 40.000MB/s transfers
da1: Attempt to query device size failed: NOT READY, Medium not present
da1: quirks=0x2<NO_6_BYTE>
da2 at umass-sim3 bus 3 scbus20 target 0 lun 0
da2: <AMI Virtual HDISK0 1.00> Removable Direct Access SCSI device
da2: Serial Number AAAABBBBCCCC3
da2: 40.000MB/s transfers
da2: Attempt to query device size failed: NOT READY, Medium not present
da2: quirks=0x2<NO_6_BYTE>
cd0 at umass-sim1 bus 1 scbus18 target 0 lun 0
cd0: <AMI Virtual CDROM0 1.00> Removable CD-ROM SCSI device
cd0: Serial Number AAAABBBBCCCC1
cd0: 40.000MB/s transfers
cd0: Attempt to query device size failed: NOT READY, Medium not present
cd0: quirks=0x10<10_BYTE_ONLY>
da3 at umass-sim3 bus 3 scbus20 target 0 lun 1
da3: <AMI Virtual HDISK1 1.00> Removable Direct Access SCSI device
da3: Serial Number AAAABBBBCCCC3
da3: 40.000MB/s transfers
da3: Attempt to query device size failed: NOT READY, Medium not present
da3: quirks=0x2<NO_6_BYTE>

These messages seem to be related to the virtual disks the SP presents to the OS, which appear to have no media present.
Is there a way to prevent these message from getting logged every 3 seconds.
I looked at devd.conf and the manpage but could not figure out a way

TIA,
Paul

 

[dlavigne]

Looks like that will be fixed in the next update: https://github.com/freenas/freenas/commit/881e5810c9d4b710a4e49841a9e3b952464099a1.

 

[Paul van der Zwan]

Thanks,
That's a nice and trivial fix ;-)
For the moment I reverted back to 9.3.1 ( mostly for jail related issues ) but I will reconsider the upgrade in the (near ?) future after this fix is in the upgrades.