thr3ads.net - freebsd stable - devd(8) complains loudly when DVD player is empty, possibly due to r298134 [May 2016]

If this information is useful, please help other people find it:
Share via:

Trond Endrestøl

2016-Apr-27 17:23 UTC

devd(8) complains loudly when DVD player is empty, possibly due to r298134

Hi,

The symptoms began after upgrading from stable/10 r298033 to stable/10 r298573.

Apr 27 18:40:00 <user.info> [HOSTNAME] devd: Processing event
'!system=CAM subsystem=periph type=error device=cd0
serial="R8KL6GKC900AFG" cam_status="0xcc" scsi_status=2
scsi_sense="70 02 04 01" CDB="00 00 00 00 00 00 " '

These messages are just seconds apart:

Apr 27 18:40:01 <user.info> [HOSTNAME] devd: Processing event
'!system=CAM subsystem=periph type=error device=pass1
serial="R8KL6GKC900AFG" cam_status="0xcc" scsi_status=2
scsi_sense="70 02 04 01" CDB="00 00 00 00 00 00 " '
Apr 27 18:40:03 <user.info> [HOSTNAME] devd: Processing event
'!system=CAM subsystem=periph type=error device=pass1
serial="R8KL6GKC900AFG" cam_status="0xcc" scsi_status=2
scsi_sense="70 02 04 01" CDB="00 00 00 00 00 00 " '
Apr 27 18:40:05 <user.info> [HOSTNAME] devd: Processing event
'!system=CAM subsystem=periph type=error device=pass1
serial="R8KL6GKC900AFG" cam_status="0xcc" scsi_status=2
scsi_sense="70 02 04 01" CDB="00 00 00 00 00 00 " '

When I put a CD or DVD in the DVD player, the messages stop. As soon 
as I eject the disc, they start appearing again.

Here's the relevant part from dmesg:

cd0 at ahcich1 bus 0 scbus1 target 0 lun 0
cd0: <TSSTcorp DVD+-RW SN-208BB D500> Removable CD-ROM SCSI device
cd0: Serial Number R8KL6GKC900AFG
cd0: 150.000MB/s transfers (SATA 1.x, UDMA5, ATAPI 12bytes, PIO 8192bytes)
cd0: Attempt to query device size failed: NOT READY, Medium not present - tray
closed

This is on a mid-2012 Dell Latitude E5530 with the stock DVD player.

Upgrading to stable/10 r298705 doesn't resolve this issue.

Does anyone else see this?

Maybe r298134 is to blame:

  stable/10/sys/cam/cam_periph.c

  MFC r298004:

  Add a devctl/devd notification conduit for CAM errors that happen at the
  periph level.

  Due to not merging the changes to ata_res_sbuf(), this version is a little
  messy.

  Sponsored by:	Netflix

http://svnweb.freebsd.org/base?view=revision&revision=298134

-- 
+-------------------------------+------------------------------------+
| Vennlig hilsen,               | Best regards,                      |
| Trond Endrest?l,              | Trond Endrest?l,                   |
| IT-ansvarlig,                 | System administrator,              |
| Fagskolen Innlandet,          | Gj?vik Technical College, Norway,  |
| tlf. mob.   952 62 567,       | Cellular...: +47 952 62 567,       |
| sentralbord 61 14 54 00.      | Switchboard: +47 61 14 54 00.      |
+-------------------------------+------------------------------------+

Scott Long

2016-Apr-27 17:46 UTC

head link

devd(8) complains loudly when DVD player is empty, possibly due to r298134

Hi Trond,

Thanks for the report.  I might be mistaken, but the default system is not
configured to direct devd messages to user.info, so I didn?t see this during my
development.  However, what you?re reporting is definitely annoying, so Warner
Losh and I are working on a solution.

Scott
> On Apr 27, 2016, at 1:23 PM, Trond Endrest?l <Trond.Endrestol at
fagskolen.gjovik.no> wrote:
> 
> Hi,
> 
> The symptoms began after upgrading from stable/10 r298033 to stable/10
r298573.
> 
> Apr 27 18:40:00 <user.info> [HOSTNAME] devd: Processing event
'!system=CAM subsystem=periph type=error device=cd0
serial="R8KL6GKC900AFG" cam_status="0xcc" scsi_status=2
scsi_sense="70 02 04 01" CDB="00 00 00 00 00 00 " '
> 
> These messages are just seconds apart:
> 
> Apr 27 18:40:01 <user.info> [HOSTNAME] devd: Processing event
'!system=CAM subsystem=periph type=error device=pass1
serial="R8KL6GKC900AFG" cam_status="0xcc" scsi_status=2
scsi_sense="70 02 04 01" CDB="00 00 00 00 00 00 " '
> Apr 27 18:40:03 <user.info> [HOSTNAME] devd: Processing event
'!system=CAM subsystem=periph type=error device=pass1
serial="R8KL6GKC900AFG" cam_status="0xcc" scsi_status=2
scsi_sense="70 02 04 01" CDB="00 00 00 00 00 00 " '
> Apr 27 18:40:05 <user.info> [HOSTNAME] devd: Processing event
'!system=CAM subsystem=periph type=error device=pass1
serial="R8KL6GKC900AFG" cam_status="0xcc" scsi_status=2
scsi_sense="70 02 04 01" CDB="00 00 00 00 00 00 " '
> 
> When I put a CD or DVD in the DVD player, the messages stop. As soon 
> as I eject the disc, they start appearing again.
> 
> Here's the relevant part from dmesg:
> 
> cd0 at ahcich1 bus 0 scbus1 target 0 lun 0
> cd0: <TSSTcorp DVD+-RW SN-208BB D500> Removable CD-ROM SCSI device
> cd0: Serial Number R8KL6GKC900AFG
> cd0: 150.000MB/s transfers (SATA 1.x, UDMA5, ATAPI 12bytes, PIO 8192bytes)
> cd0: Attempt to query device size failed: NOT READY, Medium not present -
tray closed
> 
> This is on a mid-2012 Dell Latitude E5530 with the stock DVD player.
> 
> Upgrading to stable/10 r298705 doesn't resolve this issue.
> 
> Does anyone else see this?
> 
> Maybe r298134 is to blame:
> 
>  stable/10/sys/cam/cam_periph.c
> 
>  MFC r298004:
> 
>  Add a devctl/devd notification conduit for CAM errors that happen at the
>  periph level.
> 
>  Due to not merging the changes to ata_res_sbuf(), this version is a little
>  messy.
> 
>  Sponsored by:	Netflix
> 
> http://svnweb.freebsd.org/base?view=revision&revision=298134
> 
> -- 
> +-------------------------------+------------------------------------+
> | Vennlig hilsen,               | Best regards,                      |
> | Trond Endrest?l,              | Trond Endrest?l,                   |
> | IT-ansvarlig,                 | System administrator,              |
> | Fagskolen Innlandet,          | Gj?vik Technical College, Norway,  |
> | tlf. mob.   952 62 567,       | Cellular...: +47 952 62 567,       |
> | sentralbord 61 14 54 00.      | Switchboard: +47 61 14 54 00.      |
> +-------------------------------+------------------------------------+
> _______________________________________________
> freebsd-stable at freebsd.org mailing list
> https://lists.freebsd.org/mailman/listinfo/freebsd-stable
> To unsubscribe, send any mail to "freebsd-stable-unsubscribe at
freebsd.org"

Trond Endrestøl

2016-May-01 15:07 UTC

head link

devd(8) complains loudly when DVD player is empty, possibly due to r298134

On Wed, 27 Apr 2016 13:46-0400, Scott Long wrote:
> Thanks for the report.  I might be mistaken, but the default system 
> is not configured to direct devd messages to user.info, so I didn?t 
> see this during my development.  However, what you?re reporting is 
> definitely annoying, so Warner Losh and I are working on a solution.
> 
> Scott
I solved the problem by running devd with -q, i.e. devd_flags="-q" in 
/etc/rc.conf. This should probably be the default anyway.

All of my systems (stable/10) have custom logging where each facility 
has its own file. Also *.*;mark.* is sent to /dev/ttyvb and to the 
central log host. /dev/ttyvb was pretty busy on the log host.

Making devd less chatty does have its merits.
The next servers I buy will probably exclude a DVD player.

Happy hacking.
> > On Apr 27, 2016, at 1:23 PM, Trond Endrest?l <Trond.Endrestol at
fagskolen.gjovik.no> wrote:
> > 
> > Hi,
> > 
> > The symptoms began after upgrading from stable/10 r298033 to stable/10
r298573.
> > 
> > Apr 27 18:40:00 <user.info> [HOSTNAME] devd: Processing event
'!system=CAM subsystem=periph type=error device=cd0
serial="R8KL6GKC900AFG" cam_status="0xcc" scsi_status=2
scsi_sense="70 02 04 01" CDB="00 00 00 00 00 00 " '
> > 
> > These messages are just seconds apart:
> > 
> > Apr 27 18:40:01 <user.info> [HOSTNAME] devd: Processing event
'!system=CAM subsystem=periph type=error device=pass1
serial="R8KL6GKC900AFG" cam_status="0xcc" scsi_status=2
scsi_sense="70 02 04 01" CDB="00 00 00 00 00 00 " '
> > Apr 27 18:40:03 <user.info> [HOSTNAME] devd: Processing event
'!system=CAM subsystem=periph type=error device=pass1
serial="R8KL6GKC900AFG" cam_status="0xcc" scsi_status=2
scsi_sense="70 02 04 01" CDB="00 00 00 00 00 00 " '
> > Apr 27 18:40:05 <user.info> [HOSTNAME] devd: Processing event
'!system=CAM subsystem=periph type=error device=pass1
serial="R8KL6GKC900AFG" cam_status="0xcc" scsi_status=2
scsi_sense="70 02 04 01" CDB="00 00 00 00 00 00 " '
> > 
> > When I put a CD or DVD in the DVD player, the messages stop. As soon 
> > as I eject the disc, they start appearing again.
> > 
> > Here's the relevant part from dmesg:
> > 
> > cd0 at ahcich1 bus 0 scbus1 target 0 lun 0
> > cd0: <TSSTcorp DVD+-RW SN-208BB D500> Removable CD-ROM SCSI
device
> > cd0: Serial Number R8KL6GKC900AFG
> > cd0: 150.000MB/s transfers (SATA 1.x, UDMA5, ATAPI 12bytes, PIO
8192bytes)
> > cd0: Attempt to query device size failed: NOT READY, Medium not
present - tray closed
> > 
> > This is on a mid-2012 Dell Latitude E5530 with the stock DVD player.
> > 
> > Upgrading to stable/10 r298705 doesn't resolve this issue.
> > 
> > Does anyone else see this?
> > 
> > Maybe r298134 is to blame:
> > 
> >  stable/10/sys/cam/cam_periph.c
> > 
> >  MFC r298004:
> > 
> >  Add a devctl/devd notification conduit for CAM errors that happen at
the
> >  periph level.
> > 
> >  Due to not merging the changes to ata_res_sbuf(), this version is a
little
> >  messy.
> > 
> >  Sponsored by:	Netflix
> > 
> > http://svnweb.freebsd.org/base?view=revision&revision=298134
-- 
+-------------------------------+------------------------------------+
| Vennlig hilsen,               | Best regards,                      |
| Trond Endrest?l,              | Trond Endrest?l,                   |
| IT-ansvarlig,                 | System administrator,              |
| Fagskolen Innlandet,          | Gj?vik Technical College, Norway,  |
| tlf. mob.   952 62 567,       | Cellular...: +47 952 62 567,       |
| sentralbord 61 14 54 00.      | Switchboard: +47 61 14 54 00.      |
+-------------------------------+------------------------------------+

freebsd stable - May 2016 - devd(8) complains loudly when DVD player is empty, possibly due to r298134

devd(8) complains loudly when DVD player is empty, possibly due to r298134

devd(8) complains loudly when DVD player is empty, possibly due to r298134

devd(8) complains loudly when DVD player is empty, possibly due to r298134