Sonos binding unknown warn messages in log

lsiepel · January 3, 2018, 11:42pm

I don’t know when it started, but somehow my logs gets flooded with this message that i don’t understand:

018-01-04 00:20:09.399 [WARN ] [s.internal.handler.ZonePlayerHandler] - Cannot update channel for group member (Could not find handler for RINCON_XXXXXXXXXXXXX)
2018-01-04 00:20:09.404 [WARN ] [s.internal.handler.ZonePlayerHandler] - Cannot update channel for group member (Could not find handler for RINCON_XXXXXXXXXXXXX)

Both things are Play 1’s setup as left/right surround added to a sonos playbar. I have not added these things, they are ignored/hidden in my inbox. The playbar itself is added as thing and has some channels boungs to items. I’m using build 1151

Any thoughts on this?

Lolodomo · January 4, 2018, 7:32am

You found yourself the explanation. Some of your devices are not added as things.

Lolodomo · January 4, 2018, 8:34am

Maybe the log level is too high and could be replaced by a DEBUG log.

lsiepel · January 4, 2018, 10:55am

Tried log:set DEBUG org.openhab.binding.sonos but that doesn’t change anything to the log. Has this debug log stuff changed or is it me doing somehing wrong.

Why would it be required to add the play 1’s ? They are not used in openhab, all control is done by the playbar, so i don’t see why openhab would complain/warn about this.

opus · January 4, 2018, 11:09am

In order to see LESS messages you should have used DEFAULT instead of DEBUG.

lsiepel · January 4, 2018, 11:18am

I have set it to debug to know why it logs this WARN message (as lolodomo suggested). I don’t want to surpress the warnings, because then i will also surpress other sonos warnings.

Lolodomo · January 4, 2018, 12:53pm

I was suggesting a change in the source code.
You will not be able to hide these warnings without a change in the code.

lsiepel · January 4, 2018, 1:18pm

I raised an issue. I think it would be best to discard this warning if there is no channel attached, because i think it is strange that a binding logs stuff about things that are not added or even intentionally hidden in the inbox.

github.com/eclipse-archived/smarthome

[sonos] media channel WARN messages while thing is not added

opened 05:19PM - 04 Jan 18 UTC

closed 12:36PM - 09 Jan 18 UTC

lsiepel

Binding-Sonos

The sonos binding shows warnings in the log while the corresponding thing is not… yet added from the inbox (or in my case is hidden in the inbox). I have a Playbar with two play 1's as left/right rear. The Playbar is added as Thing in openhab, the Play 1's are not. All works as expected except for these WARN messages in the log. The RINCON points to both play 1's. And that is a bit strange, because they are not used in openhab. No thing, no channels. As far as i know there are two different warnings added to the log every time a different track is played on the Sonos Playbar: [WARN ] [s.internal.handler.ZonePlayerHandler] - Cannot update media data for group member (Could not find handler for RINCON_XXXXXXXXXXXXX) [WARN ] [s.internal.handler.ZonePlayerHandler] - Cannot update channel for group member (Could not find handler for RINCON_XXXXXXXXXXXXX) This is with build 1162 and when i check my logs, this is happening for months, can't determine with what build it was introduced.

cweitkamp · January 4, 2018, 4:36pm

Please try to set the log level for the package org.eclipse.smarthome.binding.sonos.

lsiepel · January 4, 2018, 5:29pm

Ah thanks. Looks like the example is wrong at this page:
https://docs.openhab.org/administration/logging.html

Added another issue for that: