I experience some strange behavior using node-raumkernel.
After running Raumkernel multiple hours in the background (often around 12-24 hours), all renderers get removed from my Raumfeld devices. This results, amongst other things, in the Raumfeld App not being usable anymore. (RFUPnP.RFUPnP Error-1)
The only option to recover from this state is to reboot the Raumfeld host.
I have tracked the event down in the logs, having LogLevel 4 set.
My guess is that its happening below at line 64 (Mar 21 11:12:03 )
Comparing to the events before, I would expect a log-line
AVTransport subscription callback triggered on device 'Wohnzimmer'
to appear, but instead this line appears:
Mar 21 11:12:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:12:03] [MediaRenderer|Wohnzimmer] Media Item on renderer changed
at this point in time, no other interaction happened with the devices as no one was at home.
Do you have any idea what the reason for this could be?
I use the standard node-raumkernel instance running in a docker container on a raspberry;
Thanks for your help!
Mar 21 10:26:59 homeassistant addon_f97079c8_spixradio[480]: '
Mar 21 10:26:59 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:26:59] [MediaRenderer|Wohnzimmer] CurrentTransportActions has changed from 'Next,Shuffle' to 'Play,Next,Shuffle'
Mar 21 10:26:59 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:26:59] [ZoneManager] Get room information object for: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7
Mar 21 10:26:59 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:26:59] [MediaRenderer|Wohnzimmer] Room: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7: Set room renderer(s) ["uuid:2107070d-7dce-4bc3-828d-d24b7ca8767d"] online to :true
Mar 21 10:26:59 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:26:59] [MediaRenderer|Wohnzimmer] Set new updateId to: 913229
Mar 21 10:26:59 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:26:59] [MediaRenderer|Wohnzimmer] Media Item on renderer changed
Mar 21 10:42:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:42:00] [MediaRenderer|Wohnzimmer] AVTransport subscription callback triggered on device 'Wohnzimmer'
Mar 21 10:42:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:42:00] [MediaRenderer|Wohnzimmer] CurrentTrackURI has changed from 'http://fluxfm.streamabc.net/flx-fluxfmberlin-mp3-128-5859035?sABC=641982s0%230%23775qsn3qp0s6037s0rpr2po992orr036%23gharva&aw_0_1st.playerid=tunein&amsparams=playerid:tunein;skey:1679393520' to ''
Mar 21 10:42:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:42:00] [MediaRenderer|Wohnzimmer] CurrentTrackMetaData has changed from '<?xml version="1.0"?>
Mar 21 10:42:00 homeassistant addon_f97079c8_spixradio[480]: <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item parentID="0/Playlists/MyPlaylists/Styrbar" id="0/Playlists/MyPlaylists/Styrbar/1763" restricted="1" refID="0/RadioTime/Search/s-s132954"><raumfeld:name>Station</raumfeld:name><upnp:class>object.item.audioItem.audioBroadcast.radio</upnp:class><raumfeld:section>RadioTime</raumfeld:section><raumfeld:durability>120</raumfeld:durability><raumfeld:ebrowse>http://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg%2Caac&serial=d0%3A5f%3Ab8%3Ac7%3A55%3A20&id=s132954&c=ebrowse</raumfeld:ebrowse><dc:title>FluxFM</dc:title><upnp:albumArtURI dlna:profileID="JPEG_TN">https://cdn-radiotime-logos.tunein.com/s132954g.png</upnp:albumArtURI><res bitrate="128" protocolInfo="http-get:*:audio/x-mpegurl:*">http://opml.radiotime.com/Tune.ashx?id=e65940766&sid=s132954&formats=mp3,ogg,aac&partnerId=7aJ9pvV5&serial=d0:5f:b8:c7:55:20</res></item></DIDL-Lite>
Mar 21 10:42:00 homeassistant addon_f97079c8_spixradio[480]: ' to ''
Mar 21 10:42:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:42:00] [MediaRenderer|Wohnzimmer] CurrentTransportActions has changed from 'Play,Next,Shuffle' to 'Next,Shuffle'
Mar 21 10:42:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:42:00] [ZoneManager] Get room information object for: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7
Mar 21 10:42:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:42:00] [MediaRenderer|Wohnzimmer] Room: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7: Set room renderer(s) ["uuid:2107070d-7dce-4bc3-828d-d24b7ca8767d"] online to :true
Mar 21 10:42:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:42:00] [MediaRenderer|Wohnzimmer] Set new updateId to: 913230
Mar 21 10:42:02 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:42:02] [MediaRenderer|Wohnzimmer] AVTransport subscription callback triggered on device 'Wohnzimmer'
Mar 21 10:42:02 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:42:02] [MediaRenderer|Wohnzimmer] CurrentTrackURI has changed from '' to 'http://fluxfm.streamabc.net/flx-fluxfmberlin-mp3-128-5859035?sABC=641989s8%230%23775qsn3qp0s6037s0rpr2po992orr036%23gharva&aw_0_1st.playerid=tunein&amsparams=playerid:tunein;skey:1679395320'
Mar 21 10:42:02 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:42:02] [MediaRenderer|Wohnzimmer] CurrentTrackMetaData has changed from '' to '<?xml version="1.0"?>
Mar 21 10:42:02 homeassistant addon_f97079c8_spixradio[480]: <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item parentID="0/Playlists/MyPlaylists/Styrbar" id="0/Playlists/MyPlaylists/Styrbar/1763" restricted="1" refID="0/RadioTime/Search/s-s132954"><raumfeld:name>Station</raumfeld:name><upnp:class>object.item.audioItem.audioBroadcast.radio</upnp:class><raumfeld:section>RadioTime</raumfeld:section><raumfeld:durability>120</raumfeld:durability><raumfeld:ebrowse>http://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg%2Caac&serial=d0%3A5f%3Ab8%3Ac7%3A55%3A20&id=s132954&c=ebrowse</raumfeld:ebrowse><dc:title>FluxFM</dc:title><upnp:albumArtURI dlna:profileID="JPEG_TN">https://cdn-radiotime-logos.tunein.com/s132954g.png</upnp:albumArtURI><res bitrate="128" protocolInfo="http-get:*:audio/x-mpegurl:*">http://opml.radiotime.com/Tune.ashx?id=e65940766&sid=s132954&formats=mp3,ogg,aac&partnerId=7aJ9pvV5&serial=d0:5f:b8:c7:55:20</res></item></DIDL-Lite>
Mar 21 10:42:02 homeassistant addon_f97079c8_spixradio[480]: '
Mar 21 10:42:02 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:42:02] [MediaRenderer|Wohnzimmer] CurrentTransportActions has changed from 'Next,Shuffle' to 'Play,Next,Shuffle'
Mar 21 10:42:02 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:42:02] [ZoneManager] Get room information object for: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7
Mar 21 10:42:02 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:42:02] [MediaRenderer|Wohnzimmer] Room: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7: Set room renderer(s) ["uuid:2107070d-7dce-4bc3-828d-d24b7ca8767d"] online to :true
Mar 21 10:42:02 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:42:02] [MediaRenderer|Wohnzimmer] Set new updateId to: 913231
Mar 21 10:42:02 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:42:02] [MediaRenderer|Wohnzimmer] Media Item on renderer changed
Mar 21 10:42:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:42:03] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 10:42:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:42:03] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 10:57:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:57:00] [MediaRenderer|Wohnzimmer] AVTransport subscription callback triggered on device 'Wohnzimmer'
Mar 21 10:57:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:57:00] [MediaRenderer|Wohnzimmer] CurrentTrackURI has changed from 'http://fluxfm.streamabc.net/flx-fluxfmberlin-mp3-128-5859035?sABC=641989s8%230%23775qsn3qp0s6037s0rpr2po992orr036%23gharva&aw_0_1st.playerid=tunein&amsparams=playerid:tunein;skey:1679395320' to ''
Mar 21 10:57:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:57:00] [MediaRenderer|Wohnzimmer] CurrentTrackMetaData has changed from '<?xml version="1.0"?>
Mar 21 10:57:00 homeassistant addon_f97079c8_spixradio[480]: <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item parentID="0/Playlists/MyPlaylists/Styrbar" id="0/Playlists/MyPlaylists/Styrbar/1763" restricted="1" refID="0/RadioTime/Search/s-s132954"><raumfeld:name>Station</raumfeld:name><upnp:class>object.item.audioItem.audioBroadcast.radio</upnp:class><raumfeld:section>RadioTime</raumfeld:section><raumfeld:durability>120</raumfeld:durability><raumfeld:ebrowse>http://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg%2Caac&serial=d0%3A5f%3Ab8%3Ac7%3A55%3A20&id=s132954&c=ebrowse</raumfeld:ebrowse><dc:title>FluxFM</dc:title><upnp:albumArtURI dlna:profileID="JPEG_TN">https://cdn-radiotime-logos.tunein.com/s132954g.png</upnp:albumArtURI><res bitrate="128" protocolInfo="http-get:*:audio/x-mpegurl:*">http://opml.radiotime.com/Tune.ashx?id=e65940766&sid=s132954&formats=mp3,ogg,aac&partnerId=7aJ9pvV5&serial=d0:5f:b8:c7:55:20</res></item></DIDL-Lite>
Mar 21 10:57:00 homeassistant addon_f97079c8_spixradio[480]: ' to ''
Mar 21 10:57:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:57:00] [MediaRenderer|Wohnzimmer] CurrentTransportActions has changed from 'Play,Next,Shuffle' to 'Next,Shuffle'
Mar 21 10:57:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:57:00] [ZoneManager] Get room information object for: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7
Mar 21 10:57:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:57:00] [MediaRenderer|Wohnzimmer] Room: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7: Set room renderer(s) ["uuid:2107070d-7dce-4bc3-828d-d24b7ca8767d"] online to :true
Mar 21 10:57:00 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:57:00] [MediaRenderer|Wohnzimmer] Set new updateId to: 913232
Mar 21 10:57:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:57:01] [MediaRenderer|Wohnzimmer] AVTransport subscription callback triggered on device 'Wohnzimmer'
Mar 21 10:57:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:57:01] [MediaRenderer|Wohnzimmer] CurrentTrackURI has changed from '' to 'http://fluxfm.streamabc.net/flx-fluxfmberlin-mp3-128-5859035?sABC=641989s8%230%23775qsn3qp0s6037s0rpr2po992orr036%23gharva&aw_0_1st.playerid=tunein&amsparams=playerid:tunein;skey:1679395320'
Mar 21 10:57:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:57:01] [MediaRenderer|Wohnzimmer] CurrentTrackMetaData has changed from '' to '<?xml version="1.0"?>
Mar 21 10:57:01 homeassistant addon_f97079c8_spixradio[480]: <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item parentID="0/Playlists/MyPlaylists/Styrbar" id="0/Playlists/MyPlaylists/Styrbar/1763" restricted="1" refID="0/RadioTime/Search/s-s132954"><raumfeld:name>Station</raumfeld:name><upnp:class>object.item.audioItem.audioBroadcast.radio</upnp:class><raumfeld:section>RadioTime</raumfeld:section><raumfeld:durability>120</raumfeld:durability><raumfeld:ebrowse>http://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg%2Caac&serial=d0%3A5f%3Ab8%3Ac7%3A55%3A20&id=s132954&c=ebrowse</raumfeld:ebrowse><dc:title>FluxFM</dc:title><upnp:albumArtURI dlna:profileID="JPEG_TN">https://cdn-radiotime-logos.tunein.com/s132954g.png</upnp:albumArtURI><res bitrate="128" protocolInfo="http-get:*:audio/x-mpegurl:*">http://opml.radiotime.com/Tune.ashx?id=e65940766&sid=s132954&formats=mp3,ogg,aac&partnerId=7aJ9pvV5&serial=d0:5f:b8:c7:55:20</res></item></DIDL-Lite>
Mar 21 10:57:01 homeassistant addon_f97079c8_spixradio[480]: '
Mar 21 10:57:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 11:57:01] [MediaRenderer|Wohnzimmer] CurrentTransportActions has changed from 'Next,Shuffle' to 'Play,Next,Shuffle'
Mar 21 10:57:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:57:01] [ZoneManager] Get room information object for: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7
Mar 21 10:57:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:57:01] [MediaRenderer|Wohnzimmer] Room: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7: Set room renderer(s) ["uuid:2107070d-7dce-4bc3-828d-d24b7ca8767d"] online to :true
Mar 21 10:57:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:57:01] [MediaRenderer|Wohnzimmer] Set new updateId to: 913233
Mar 21 10:57:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 11:57:01] [MediaRenderer|Wohnzimmer] Media Item on renderer changed
Mar 21 11:12:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:12:01] [MediaRenderer|Wohnzimmer] AVTransport subscription callback triggered on device 'Wohnzimmer'
Mar 21 11:12:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:12:01] [MediaRenderer|Wohnzimmer] CurrentTrackURI has changed from 'http://fluxfm.streamabc.net/flx-fluxfmberlin-mp3-128-5859035?sABC=641989s8%230%23775qsn3qp0s6037s0rpr2po992orr036%23gharva&aw_0_1st.playerid=tunein&amsparams=playerid:tunein;skey:1679395320' to ''
Mar 21 11:12:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:12:01] [MediaRenderer|Wohnzimmer] CurrentTrackMetaData has changed from '<?xml version="1.0"?>
Mar 21 11:12:01 homeassistant addon_f97079c8_spixradio[480]: <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item parentID="0/Playlists/MyPlaylists/Styrbar" id="0/Playlists/MyPlaylists/Styrbar/1763" restricted="1" refID="0/RadioTime/Search/s-s132954"><raumfeld:name>Station</raumfeld:name><upnp:class>object.item.audioItem.audioBroadcast.radio</upnp:class><raumfeld:section>RadioTime</raumfeld:section><raumfeld:durability>120</raumfeld:durability><raumfeld:ebrowse>http://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg%2Caac&serial=d0%3A5f%3Ab8%3Ac7%3A55%3A20&id=s132954&c=ebrowse</raumfeld:ebrowse><dc:title>FluxFM</dc:title><upnp:albumArtURI dlna:profileID="JPEG_TN">https://cdn-radiotime-logos.tunein.com/s132954g.png</upnp:albumArtURI><res bitrate="128" protocolInfo="http-get:*:audio/x-mpegurl:*">http://opml.radiotime.com/Tune.ashx?id=e65940766&sid=s132954&formats=mp3,ogg,aac&partnerId=7aJ9pvV5&serial=d0:5f:b8:c7:55:20</res></item></DIDL-Lite>
Mar 21 11:12:01 homeassistant addon_f97079c8_spixradio[480]: ' to ''
Mar 21 11:12:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:12:01] [MediaRenderer|Wohnzimmer] CurrentTransportActions has changed from 'Play,Next,Shuffle' to 'Next,Shuffle'
Mar 21 11:12:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:12:01] [ZoneManager] Get room information object for: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7
Mar 21 11:12:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:12:01] [MediaRenderer|Wohnzimmer] Room: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7: Set room renderer(s) ["uuid:2107070d-7dce-4bc3-828d-d24b7ca8767d"] online to :true
Mar 21 11:12:01 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:12:01] [MediaRenderer|Wohnzimmer] Set new updateId to: 913234
Mar 21 11:12:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:12:03] [MediaRenderer|Wohnzimmer] AVTransport subscription callback triggered on device 'Wohnzimmer'
Mar 21 11:12:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:12:03] [MediaRenderer|Wohnzimmer] CurrentTrackURI has changed from '' to 'http://fluxfm.streamabc.net/flx-fluxfmberlin-mp3-128-5859035?sABC=64199101%230%23775qsn3qp0s6037s0rpr2po992orr036%23gharva&aw_0_1st.playerid=tunein&amsparams=playerid:tunein;skey:1679397121'
Mar 21 11:12:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:12:03] [MediaRenderer|Wohnzimmer] CurrentTrackMetaData has changed from '' to '<?xml version="1.0"?>
Mar 21 11:12:03 homeassistant addon_f97079c8_spixradio[480]: <DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:raumfeld="urn:schemas-raumfeld-com:meta-data/raumfeld" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:pv="http://www.pv.com/pvns/" lang="en"><item parentID="0/Playlists/MyPlaylists/Styrbar" id="0/Playlists/MyPlaylists/Styrbar/1763" restricted="1" refID="0/RadioTime/Search/s-s132954"><raumfeld:name>Station</raumfeld:name><upnp:class>object.item.audioItem.audioBroadcast.radio</upnp:class><raumfeld:section>RadioTime</raumfeld:section><raumfeld:durability>120</raumfeld:durability><raumfeld:ebrowse>http://opml.radiotime.com/Tune.ashx?partnerId=7aJ9pvV5&formats=mp3%2Cogg%2Caac&serial=d0%3A5f%3Ab8%3Ac7%3A55%3A20&id=s132954&c=ebrowse</raumfeld:ebrowse><dc:title>FluxFM</dc:title><upnp:albumArtURI dlna:profileID="JPEG_TN">https://cdn-radiotime-logos.tunein.com/s132954g.png</upnp:albumArtURI><res bitrate="128" protocolInfo="http-get:*:audio/x-mpegurl:*">http://opml.radiotime.com/Tune.ashx?id=e65940766&sid=s132954&formats=mp3,ogg,aac&partnerId=7aJ9pvV5&serial=d0:5f:b8:c7:55:20</res></item></DIDL-Lite>
Mar 21 11:12:03 homeassistant addon_f97079c8_spixradio[480]: '
Mar 21 11:12:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:12:03] [MediaRenderer|Wohnzimmer] CurrentTransportActions has changed from 'Next,Shuffle' to 'Play,Next,Shuffle'
Mar 21 11:12:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:12:03] [ZoneManager] Get room information object for: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7
Mar 21 11:12:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:12:03] [MediaRenderer|Wohnzimmer] Room: uuid:93729fff-e1e7-4ab6-a032-d368cd1ed6c7: Set room renderer(s) ["uuid:2107070d-7dce-4bc3-828d-d24b7ca8767d"] online to :true
Mar 21 11:12:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:12:03] [MediaRenderer|Wohnzimmer] Set new updateId to: 913235
Mar 21 11:12:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:12:03] [MediaRenderer|Wohnzimmer] Media Item on renderer changed
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Device list request returns with updateId: '1098085778'
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Device list changed
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Cleaning up devices
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Cleaning up mediaServers
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Cleaning up virtual renderers
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [MediaRenderer|Wohnzimmer] Remove service subscriptions for device 'Wohnzimmer'
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-1][21.3.2023, 12:26:22] [DeviceManager] Virtual media renderer removed: Wohnzimmer
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Cleaning up renderers
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Get device description from http://192.168.178.98:55528/2107070d-7dce-4bc3-828d-d24b7ca8767d.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Get device description from http://192.168.178.121:58867/40ec5af4-284b-4dda-8f3c-857b2e67f4a8.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Get device description from http://192.168.178.121:59876/4fc35991-f606-42a2-a554-856c2e8dd55e.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Get device description from http://192.168.178.121:57695/5dc5701c-bbf2-4ca5-a246-f11db4a2ef7d.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Get device description from http://192.168.178.121:55878/6249847f-1f7d-4a1b-981b-9e0e9c775e46.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Get device description from http://192.168.178.121:58828/846851e1-0ad8-4664-b38a-5656ef1fb4ee.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Get device description from http://192.168.178.98:55022/a4fc1476-c164-4568-8de7-f3d7dcaf2398.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Get device description from http://192.168.178.23:57543/ad088247-2327-4545-8d11-ff573edf1bc3.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Get device description from http://192.168.178.121:54215/d0bb4d3f-ede7-46cc-8ae8-71bf9a07d9b1.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Get device description from http://192.168.178.23:57313/f3734234-b01b-4744-b594-2617a176cbe4.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Getting device list from http://192.168.178.121 with updateId: 1098085778
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Got device description from http://192.168.178.98:55022/a4fc1476-c164-4568-8de7-f3d7dcaf2398.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Device 'Teufel Raumfeld Device' of type 'urn:schemas-raumfeld-com:device:RaumfeldDevice:1' (undefined) not usable
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Got device description from http://192.168.178.23:57543/ad088247-2327-4545-8d11-ff573edf1bc3.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Device 'Teufel Raumfeld Device' of type 'urn:schemas-raumfeld-com:device:RaumfeldDevice:1' (undefined) not usable
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Got device description from http://192.168.178.98:55528/2107070d-7dce-4bc3-828d-d24b7ca8767d.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Media renderer 'Speaker Wohnzimmer' found
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Raumfeld media renderer 'Speaker Wohnzimmer' is useable
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Got device description from http://192.168.178.23:57313/f3734234-b01b-4744-b594-2617a176cbe4.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Media renderer 'Speaker Schlafzimmer' found
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Raumfeld media renderer 'Speaker Schlafzimmer' is useable
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Got device description from http://192.168.178.121:58867/40ec5af4-284b-4dda-8f3c-857b2e67f4a8.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Device 'Raumfeld ConfigDevice' of type 'urn:schemas-raumfeld-com:device:ConfigDevice:1' (undefined) not usable
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Got device description from http://192.168.178.121:57695/5dc5701c-bbf2-4ca5-a246-f11db4a2ef7d.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Device 'Teufel Raumfeld Device' of type 'urn:schemas-raumfeld-com:device:RaumfeldDevice:1' (undefined) not usable
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Got device description from http://192.168.178.121:58828/846851e1-0ad8-4664-b38a-5656ef1fb4ee.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Media renderer 'Speaker Arbeitszimmer' found
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Raumfeld media renderer 'Speaker Arbeitszimmer' is useable
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-0][21.3.2023, 12:26:22] [MediaRenderer|Wohnzimmer] Error: UNSUBSCRIBE error
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-0][21.3.2023, 12:26:22] [MediaRenderer|Wohnzimmer] Error: UNSUBSCRIBE error
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:26:22] [DeviceManager] Got device description from http://192.168.178.121:54215/d0bb4d3f-ede7-46cc-8ae8-71bf9a07d9b1.xml
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Media server 'Raumfeld MediaServer' found
Mar 21 11:26:22 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-3][21.3.2023, 12:26:22] [DeviceManager] Media server 'Raumfeld MediaServer' is useable
Mar 21 11:42:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:42:03] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 11:42:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 12:42:03] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 12:42:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 13:42:03] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 12:42:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 13:42:03] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 13:42:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 14:42:03] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 13:42:03 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 14:42:03] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 14:42:05 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 15:42:05] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 14:42:05 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 15:42:05] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 15:42:07 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 16:42:07] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 15:42:07 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 16:42:07] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 16:42:05 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 17:42:05] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 16:42:05 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 17:42:05] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 17:42:05 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 18:42:05] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 17:42:05 homeassistant addon_f97079c8_spixradio[480]: [RAUMKERNEL][level-4][21.3.2023, 18:42:05] ContentDirectory subscription callback triggered on device 'Raumfeld MediaServer'
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]: tried to get non-virtual renderer for udn. uuid:386ee664-efcc-44da-b468-c359a9bfe44c undefined
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]: Could not load zone renderer for UDN uuid:386ee664-efcc-44da-b468-c359a9bfe44c
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]: file:///app/app/RaumkernelHelper/RaumkernelHelper.js:385
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]: let rendererUDNs = _mediaRendererVirtual.getRoomRendererUDNs();
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]: ^
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]:
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]: TypeError: Cannot read properties of undefined (reading 'getRoomRendererUDNs')
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]: at RaumkernelHelper.leaveStandby (file:///app/app/RaumkernelHelper/RaumkernelHelper.js:385:50)
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]: at RaumkernelHelper.playFavourite (file:///app/app/RaumkernelHelper/RaumkernelHelper.js:335:14)
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]:
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]: Node.js v19.8.1
Mar 21 18:39:26 homeassistant addon_f97079c8_spixradio[480]: error Command failed with exit code 1.
Hi,
I experience some strange behavior using node-raumkernel.
After running Raumkernel multiple hours in the background (often around 12-24 hours), all renderers get removed from my Raumfeld devices. This results, amongst other things, in the Raumfeld App not being usable anymore. (RFUPnP.RFUPnP Error-1)
The only option to recover from this state is to reboot the Raumfeld host.
I have tracked the event down in the logs, having LogLevel 4 set.
My guess is that its happening below at line 64
(Mar 21 11:12:03 )
Comparing to the events before, I would expect a log-line
to appear, but instead this line appears:
at this point in time, no other interaction happened with the devices as no one was at home.
Do you have any idea what the reason for this could be? I use the standard node-raumkernel instance running in a docker container on a raspberry;
Thanks for your help!