Oct 02 13:19:03 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:03 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:04 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:04 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:10 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:10 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:11 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:11 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:18 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:18 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:19 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:19 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:22 rivoplus volumio[3576]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 02 13:19:22 rivoplus volumio[3576]: info: Preload queue cleared Oct 02 13:19:22 rivoplus volumio[3576]: info: Preloading song: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776598 Oct 02 13:19:22 rivoplus volumio[3576]: info: Preloading song: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776608 Oct 02 13:19:22 rivoplus volumio[3576]: info: Preloading song: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776599 Oct 02 13:19:22 rivoplus volumio[3576]: info: Preloading song: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776600 Oct 02 13:19:22 rivoplus volumio[3576]: info: Preloading song: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776601 Oct 02 13:19:22 rivoplus volumio[3576]: info: Preloading song: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776602 Oct 02 13:19:22 rivoplus volumio[3576]: info: Preloading song: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776603 Oct 02 13:19:22 rivoplus volumio[3576]: info: Preloading song: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776604 Oct 02 13:19:22 rivoplus volumio[3576]: info: Preloading song: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776605 Oct 02 13:19:22 rivoplus volumio[3576]: info: Preloading song: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776606 Oct 02 13:19:22 rivoplus volumio[3576]: info: Preloading song: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776587 Oct 02 13:19:22 rivoplus volumio[3576]: info: Preloading song: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776607 Oct 02 13:19:22 rivoplus volumio[3576]: info: Exploding uri upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776598 in service upnp_browser Oct 02 13:19:22 rivoplus volumio[3576]: info: Exploding uri upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776608 in service upnp_browser Oct 02 13:19:22 rivoplus volumio[3576]: info: Exploding uri upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776599 in service upnp_browser Oct 02 13:19:22 rivoplus volumio[3576]: info: Exploding uri upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776600 in service upnp_browser Oct 02 13:19:22 rivoplus volumio[3576]: info: Exploding uri upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776601 in service upnp_browser Oct 02 13:19:22 rivoplus volumio[3576]: info: Exploding uri upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776602 in service upnp_browser Oct 02 13:19:22 rivoplus volumio[3576]: info: Exploding uri upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776603 in service upnp_browser Oct 02 13:19:22 rivoplus volumio[3576]: info: Exploding uri upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776604 in service upnp_browser Oct 02 13:19:22 rivoplus volumio[3576]: info: Exploding uri upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776605 in service upnp_browser Oct 02 13:19:22 rivoplus volumio[3576]: info: Exploding uri upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776606 in service upnp_browser Oct 02 13:19:22 rivoplus volumio[3576]: info: Exploding uri upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776587 in service upnp_browser Oct 02 13:19:22 rivoplus volumio[3576]: info: Exploding uri upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776607 in service upnp_browser Oct 02 13:19:23 rivoplus volumio[3576]: error: error Oct 02 13:19:23 rivoplus volumio[3576]: error: error Oct 02 13:19:27 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:27 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:29 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:29 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:29 rivoplus volumio[3576]: error: error Oct 02 13:19:29 rivoplus volumio[3576]: info: VolumeController::SetAlsaVolume40 Oct 02 13:19:29 rivoplus volumio[3576]: info: CoreStateMachine::pushState Oct 02 13:19:29 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:29 rivoplus volumio[3576]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:19:29 rivoplus volumio[3576]: info: CoreCommandRouter::volumioPushState Oct 02 13:19:29 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:29 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:29 rivoplus volumio[3576]: info: MRS: Pushing multiroomSync output update for this device Oct 02 13:19:29 rivoplus volumio[3576]: info: MRS: Pushing multiroomSync output Oct 02 13:19:29 rivoplus volumio[3576]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Oct 02 13:19:29 rivoplus volumio[3576]: SPOTIFY: SPOTIFY VOLUME 100 Oct 02 13:19:29 rivoplus volumio[3576]: SPOTIFY: VOLUMIO VOLUME 40 Oct 02 13:19:29 rivoplus volumio[3576]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 02 13:19:29 rivoplus volumio[3576]: info: Setting Spotify Volume from Volumio: 40 Oct 02 13:19:29 rivoplus volumio[3576]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 02 13:19:29 rivoplus volumio[3576]: info: Updating RAAT Signal Path Oct 02 13:19:29 rivoplus volumio[3576]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 02 13:19:30 rivoplus volumio[3576]: SPOTIFY: SETTING SPOTIFY VOLUME 40 Oct 02 13:19:30 rivoplus volumio[3576]: info: Sending Spotify command with payload to local API: /player/volume Oct 02 13:19:30 rivoplus go-librespot[4046]: time="2026-10-02T13:19:30+02:00" level=debug msg="update volume requested to 26214/65535" Oct 02 13:19:33 rivoplus volumio[3576]: info: Preload queue cleared Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::ClearQueue Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::stop Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:19:33 rivoplus volumio[3576]: info: CorePlayQueue::clearPlayQueue Oct 02 13:19:33 rivoplus volumio[3576]: info: CorePlayQueue::saveQueue Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::addQueueItems Oct 02 13:19:33 rivoplus volumio[3576]: info: CorePlayQueue::addQueueItems Oct 02 13:19:33 rivoplus volumio[3576]: info: Preload queue cleared Oct 02 13:19:33 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776598 Oct 02 13:19:33 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776598 Oct 02 13:19:33 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776608 Oct 02 13:19:33 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776608 Oct 02 13:19:33 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776599 Oct 02 13:19:33 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776599 Oct 02 13:19:33 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776600 Oct 02 13:19:33 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776600 Oct 02 13:19:33 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776601 Oct 02 13:19:33 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776601 Oct 02 13:19:33 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776602 Oct 02 13:19:33 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776602 Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:19:33 rivoplus volumio[3576]: info: CorePlayQueue::saveQueue Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::updateTrackBlock Oct 02 13:19:33 rivoplus volumio[3576]: info: CorePlayQueue::getTrackBlock Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:33 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreCommandRouter::volumioPlay Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::play index 5 Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::addQueueItems Oct 02 13:19:33 rivoplus volumio[3576]: info: CorePlayQueue::addQueueItems Oct 02 13:19:33 rivoplus volumio[3576]: info: Preload queue cleared Oct 02 13:19:33 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776603 Oct 02 13:19:33 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776603 Oct 02 13:19:33 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776604 Oct 02 13:19:33 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776604 Oct 02 13:19:33 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776605 Oct 02 13:19:33 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776605 Oct 02 13:19:33 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776606 Oct 02 13:19:33 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776606 Oct 02 13:19:33 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776587 Oct 02 13:19:33 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776587 Oct 02 13:19:33 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776607 Oct 02 13:19:33 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776607 Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::stop Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:19:33 rivoplus volumio[3576]: info: CorePlayQueue::saveQueue Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::play index undefined Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:19:33 rivoplus volumio[3576]: info: CoreStateMachine::updateTrackBlock Oct 02 13:19:33 rivoplus volumio[3576]: info: CorePlayQueue::getTrackBlock Oct 02 13:19:33 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 5 Oct 02 13:19:35 rivoplus go-librespot[4046]: time="2026-10-02T13:19:35+02:00" level=error msg="failed put state after volume change" error="context deadline exceeded" Oct 02 13:19:35 rivoplus go-librespot[4046]: time="2026-10-02T13:19:35+02:00" level=trace msg="emitting websocket event: volume" Oct 02 13:19:35 rivoplus volumio[3576]: SPOTIFY: received: {"type":"volume","data":{"max":100,"value":40}} Oct 02 13:19:35 rivoplus volumio[3576]: SPOTIFY: RECEIVED SPOTIFY VOLUME 40 Oct 02 13:19:39 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:39 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:40 rivoplus volumio[3576]: info: Preload queue cleared Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::ClearQueue Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::stop Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:19:40 rivoplus volumio[3576]: info: CorePlayQueue::clearPlayQueue Oct 02 13:19:40 rivoplus volumio[3576]: info: CorePlayQueue::saveQueue Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::addQueueItems Oct 02 13:19:40 rivoplus volumio[3576]: info: CorePlayQueue::addQueueItems Oct 02 13:19:40 rivoplus volumio[3576]: info: Preload queue cleared Oct 02 13:19:40 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776598 Oct 02 13:19:40 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776598 Oct 02 13:19:40 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776608 Oct 02 13:19:40 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776608 Oct 02 13:19:40 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776599 Oct 02 13:19:40 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776599 Oct 02 13:19:40 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776600 Oct 02 13:19:40 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776600 Oct 02 13:19:40 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776601 Oct 02 13:19:40 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776601 Oct 02 13:19:40 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776602 Oct 02 13:19:40 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776602 Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:19:40 rivoplus volumio[3576]: info: CorePlayQueue::saveQueue Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::updateTrackBlock Oct 02 13:19:40 rivoplus volumio[3576]: info: CorePlayQueue::getTrackBlock Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:40 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreCommandRouter::volumioPlay Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::play index 5 Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::addQueueItems Oct 02 13:19:40 rivoplus volumio[3576]: info: CorePlayQueue::addQueueItems Oct 02 13:19:40 rivoplus volumio[3576]: info: Preload queue cleared Oct 02 13:19:40 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776603 Oct 02 13:19:40 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776603 Oct 02 13:19:40 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776604 Oct 02 13:19:40 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776604 Oct 02 13:19:40 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776605 Oct 02 13:19:40 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776605 Oct 02 13:19:40 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776606 Oct 02 13:19:40 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776606 Oct 02 13:19:40 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776587 Oct 02 13:19:40 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776587 Oct 02 13:19:40 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776607 Oct 02 13:19:40 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776607 Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::stop Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:19:40 rivoplus volumio[3576]: info: CorePlayQueue::saveQueue Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::play index undefined Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:19:40 rivoplus volumio[3576]: info: CoreStateMachine::updateTrackBlock Oct 02 13:19:40 rivoplus volumio[3576]: info: CorePlayQueue::getTrackBlock Oct 02 13:19:40 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 5 Oct 02 13:19:43 rivoplus volumio[3576]: info: Listing playlists Oct 02 13:19:47 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:47 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreStateMachine::ClearQueue Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreStateMachine::stop Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:19:49 rivoplus volumio[3576]: info: CorePlayQueue::clearPlayQueue Oct 02 13:19:49 rivoplus volumio[3576]: info: CorePlayQueue::saveQueue Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreStateMachine::addQueueItems Oct 02 13:19:49 rivoplus volumio[3576]: info: CorePlayQueue::addQueueItems Oct 02 13:19:49 rivoplus volumio[3576]: info: Preload queue cleared Oct 02 13:19:49 rivoplus volumio[3576]: info: Adding Item to queue: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776602 Oct 02 13:19:49 rivoplus volumio[3576]: info: Using cached record of: upnp/http://192.168.178.22:50001/ContentDirectory/control@22$@776602 Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:19:49 rivoplus volumio[3576]: info: CorePlayQueue::saveQueue Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreStateMachine::updateTrackBlock Oct 02 13:19:49 rivoplus volumio[3576]: info: CorePlayQueue::getTrackBlock Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:49 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreCommandRouter::volumioPlay Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreStateMachine::play index 0 Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreStateMachine::stop Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreStateMachine::play index undefined Oct 02 13:19:49 rivoplus volumio[3576]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:19:49 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:57 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:57 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:19:57 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:19:57 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:20:05 rivoplus volumio[3576]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Oct 02 13:20:05 rivoplus volumio[3576]: error: Could not enable audio output: Device not found or multiroom not enabled Oct 02 13:20:11 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:20:11 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:20:13 rivoplus volumio[3576]: info: CoreCommandRouter::volumioGetState Oct 02 13:20:13 rivoplus volumio[3576]: info: CorePlayQueue::getTrack 0 Oct 02 13:20:13 rivoplus volumio[3576]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput Oct 02 13:20:13 rivoplus volumio[3576]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 13:20:13 rivoplus volumio[3576]: TypeError: Cannot read properties of undefined (reading 'then') Oct 02 13:20:13 rivoplus volumio[3576]: at outputs.disableAudioOutput (/volumio/app/plugins/audio_interface/outputs/index.js:273:9) Oct 02 13:20:13 rivoplus volumio[3576]: at CoreCommandRouter.disableAudioOutput (/volumio/app/index.js:2257:30) Oct 02 13:20:13 rivoplus volumio[3576]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1455:26) Oct 02 13:20:13 rivoplus volumio[3576]: at Socket.emit (node:events:514:28) Oct 02 13:20:13 rivoplus volumio[3576]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 02 13:20:13 rivoplus volumio[3576]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 02 13:20:13 rivoplus volumio[3576]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 13:20:13 rivoplus sudo[6648]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-02 13:19' Oct 02 13:20:13 rivoplus sudo[6648]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="8ed05bf20f96eb8557ed5652c420f84f39d66325" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0a52c1fb90959ba1872a2fb0225e56fe615b19ac" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 16 19:25:00 UTC 2026" VOLUMIO_VERSION="4.209" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="8dac812ca078a701f8c50cfd99202138"