-- Logs begin at Wed 2025-10-22 18:38:42 CEST, end at Sun 2025-10-26 11:00:46 CET. -- Oct 26 10:59:02 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:02 rivoplus-2025 sudo[4811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 10:59:02 rivoplus-2025 sudo[4811]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 10:59:02 rivoplus-2025 sudo[4811]: pam_unix(sudo:session): session closed for user root Oct 26 10:59:02 rivoplus-2025 sudo[4814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 10:59:02 rivoplus-2025 sudo[4814]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 10:59:02 rivoplus-2025 sudo[4814]: pam_unix(sudo:session): session closed for user root Oct 26 10:59:02 rivoplus-2025 volumio[3536]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.12 UA: Mozilla/5.0 (Linux; Android 15; SM-A546B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Oct 26 10:59:02 rivoplus-2025 sudo[4819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 10:59:02 rivoplus-2025 sudo[4819]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 10:59:02 rivoplus-2025 sudo[4819]: pam_unix(sudo:session): session closed for user root Oct 26 10:59:02 rivoplus-2025 sudo[4828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 10:59:02 rivoplus-2025 sudo[4828]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 10:59:02 rivoplus-2025 sudo[4828]: pam_unix(sudo:session): session closed for user root Oct 26 10:59:02 rivoplus-2025 volumio[3536]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.12 UA: Mozilla/5.0 (Linux; Android 15; SM-A546B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetVisibleSources Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetQueue Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreStateMachine::getQueue Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getQueue Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: Listing playlists Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: Received Get System Info Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 26 10:59:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 26 10:59:04 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 26 10:59:04 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 10:59:04 rivoplus-2025 volumio[3536]: info: Received Get System Info Oct 26 10:59:04 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 10:59:04 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 10:59:04 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 10:59:04 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:04 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 10:59:05 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 10:59:05 rivoplus-2025 volumio[3536]: info: Received Get System Info Oct 26 10:59:05 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 10:59:05 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 10:59:05 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 10:59:05 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:05 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Preload queue cleared Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::ClearQueue Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::stop Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::stPlaybackTimer Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::updateTrackBlock Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrackBlock Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 1 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::serviceStop Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 1 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::serviceStop Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: [1761472749807] ControllerTidal::stop Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: ControllerMpd::stop Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand stop Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::clearPlayQueue Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::saveQueue Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushQueue Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::addQueueItems Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::addQueueItems Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Preload queue cleared Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Adding Item to queue: tidal://song/52577957 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Using cached record of: tidal://song/52577957 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Adding Item to queue: tidal://song/18251006 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Using cached record of: tidal://song/18251006 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushQueue Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::saveQueue Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::updateTrackBlock Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrackBlock Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPlay Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::play index 1 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::addQueueItems Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::addQueueItems Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Preload queue cleared Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Adding Item to queue: tidal://song/24577678 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Using cached record of: tidal://song/24577678 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::stop Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushQueue Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::saveQueue Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::play index undefined Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::updateTrackBlock Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrackBlock Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 1 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::startPlaybackTimer Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 1 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: [1761472749844] ControllerTidal::clearAddPlayTrack Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Getting stream with soundQuality LOSSLESS Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand stop Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:09 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces state update: player Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: sendMpdCommand stop took 45 milliseconds Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: ControllerMpd::getState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: sendMpdCommand stop took 9 milliseconds Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand clear Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:09 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces state update: player Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: ControllerMpd::getState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:09 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces system playlist update Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Ignoring MPD Status Update Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: sendMpdCommand status took 4 milliseconds Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: sendMpdCommand clear took 4 milliseconds Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/18251006&soundQuality=LOSSLESS" Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:09 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces system playlist update Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Ignoring MPD Status Update Oct 26 10:59:09 rivoplus-2025 volumio[3536]: error: updateQueue error: null Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:09 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces system playlist update Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Ignoring MPD Status Update Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: sendMpdCommand status took 19 milliseconds Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: ------------------------------ 17ms Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: sendMpdCommand playlistinfo took 16 milliseconds Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/18251006&soundQuality=LOSSLESS" took 16 milliseconds Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: ------------------------------ 15ms Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand play Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: ControllerMpd::pushState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::servicePushState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 1 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 26 10:59:09 rivoplus-2025 volumio[3536]: verbose: CURRENT POSITION 1 Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState stateService stop Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState currentStatus stop Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: No code Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:09 rivoplus-2025 volumio[3536]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 26 10:59:09 rivoplus-2025 volumio[3536]: STREAMING PROXY: Handling url /?data=tidal://song/18251006&soundQuality=LOSSLESS Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: ------------------------------ 57ms Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: ------------------------------ 61ms Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: ------------------------------ 50ms Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: sendMpdCommand play took 46 milliseconds Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:09 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces system playlist update Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Ignoring MPD Status Update Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: ------------------------------ 13ms Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: MCU Signalled Playback Inactive Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: Executing endpoint getStreamUrltidal Oct 26 10:59:09 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: MCU Signalled Playback Active Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: getStreamUrl took 256 milliseconds Oct 26 10:59:10 rivoplus-2025 volumio[3536]: STREAMING PROXY: Got real url: http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidhZTFmNWY1YzQ0OWNjNjBlMzIwZTUxODBiZjQyN2YzNl82MS5tcDQ/0.flac?token=1761476297~NGFkYTZiNDFjNjY5YzVjMDkxZThmNzQyNDVkY2IzZGI2YmIxYzJhOQ== Oct 26 10:59:10 rivoplus-2025 volumio[3536]: STREAMING PROXY: Response: 200, length: 18548397 Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:10 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces state update: player Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: ControllerMpd::getState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:10 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces state update: player Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: ControllerMpd::getState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:10 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces state update: player Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: sendMpdCommand status took 13 milliseconds Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: ControllerMpd::getState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: sendMpdCommand status took 13 milliseconds Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:10 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces state update: player Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: ControllerMpd::getState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: sendMpdCommand status took 8 milliseconds Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: sendMpdCommand status took 2 milliseconds Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: ControllerMpd::pushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::servicePushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 1 Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"18251006&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/18251006&soundQuality=LOSSLESS","trackType":"tidal"} Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: CURRENT POSITION 1 Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState stateService play Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState currentStatus stop Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: ControllerMpd::pushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::servicePushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 1 Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"18251006&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/18251006&soundQuality=LOSSLESS","trackType":"tidal"} Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: CURRENT POSITION 1 Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState stateService play Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Received an update from plugin. extracting info from payload Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: ------------------------------ 40ms Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: ------------------------------ 44ms Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: sendMpdCommand playlistinfo took 22 milliseconds Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: sendMpdCommand playlistinfo took 21 milliseconds Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: ControllerMpd::pushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::servicePushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 1 Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"18251006&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/18251006&soundQuality=LOSSLESS","trackType":"tidal"} Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: CURRENT POSITION 1 Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState stateService play Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Received an update from plugin. extracting info from payload Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: ControllerMpd::pushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::servicePushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 1 Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"18251006&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/18251006&soundQuality=LOSSLESS","trackType":"tidal"} Oct 26 10:59:10 rivoplus-2025 volumio[3536]: verbose: CURRENT POSITION 1 Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState stateService play Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Received an update from plugin. extracting info from payload Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: ------------------------------ 79ms Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: ------------------------------ 67ms Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:10 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:10 rivoplus-2025 volumio[3536]: STREAMING PROXY: Client dropped request, destroying Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Preload queue cleared Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::ClearQueue Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::stop Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::stPlaybackTimer Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::updateTrackBlock Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrackBlock Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 1 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::serviceStop Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 1 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::serviceStop Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: [1761472752656] ControllerTidal::stop Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: ControllerMpd::stop Oct 26 10:59:12 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand stop Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CorePlayQueue::clearPlayQueue Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CorePlayQueue::saveQueue Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushQueue Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::addQueueItems Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CorePlayQueue::addQueueItems Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Preload queue cleared Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Adding Item to queue: tidal://song/52577957 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Using cached record of: tidal://song/52577957 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Adding Item to queue: tidal://song/18251006 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Using cached record of: tidal://song/18251006 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Adding Item to queue: tidal://song/24577678 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Using cached record of: tidal://song/24577678 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushQueue Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CorePlayQueue::saveQueue Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::updateTrackBlock Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrackBlock Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPlay Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::play index 2 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::stop Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::play index undefined Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 2 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::startPlaybackTimer Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 2 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: [1761472752676] ControllerTidal::clearAddPlayTrack Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Getting stream with soundQuality LOSSLESS Oct 26 10:59:12 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand stop Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:12 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces state update: player Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: sendMpdCommand stop took 32 milliseconds Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: ControllerMpd::getState Oct 26 10:59:12 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: sendMpdCommand stop took 15 milliseconds Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: sendMpdCommand status took 1 milliseconds Oct 26 10:59:12 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand clear Oct 26 10:59:12 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseState Oct 26 10:59:12 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:12 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces state update: player Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: ControllerMpd::getState Oct 26 10:59:12 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:12 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces system playlist update Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Ignoring MPD Status Update Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: sendMpdCommand clear took 4 milliseconds Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: sendMpdCommand status took 3 milliseconds Oct 26 10:59:12 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/24577678&soundQuality=LOSSLESS" Oct 26 10:59:12 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:59:12 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseState Oct 26 10:59:12 rivoplus-2025 volumio[3536]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: ControllerMpd::pushState Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::servicePushState Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 2 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 2 Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: ------------------------------ 18ms Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: ------------------------------ 16ms Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:12 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces system playlist update Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Ignoring MPD Status Update Oct 26 10:59:12 rivoplus-2025 volumio[3536]: error: updateQueue error: null Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:12 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces system playlist update Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Ignoring MPD Status Update Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: ------------------------------ 19ms Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/24577678&soundQuality=LOSSLESS" took 16 milliseconds Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 26 10:59:12 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand play Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:12 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces system playlist update Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Ignoring MPD Status Update Oct 26 10:59:12 rivoplus-2025 volumio[3536]: STREAMING PROXY: Handling url /?data=tidal://song/24577678&soundQuality=LOSSLESS Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: ------------------------------ 19ms Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: ------------------------------ 17ms Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: sendMpdCommand play took 15 milliseconds Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: ------------------------------ 15ms Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: Executing endpoint getStreamUrltidal Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: MCU Signalled Playback Inactive Oct 26 10:59:12 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: getStreamUrl took 270 milliseconds Oct 26 10:59:13 rivoplus-2025 volumio[3536]: STREAMING PROXY: Got real url: http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidiNGM2ZjA2YmE1MGFiNWMyMTEzZjkzYjQ1YzQzYmViYl82MS5tcDQ/0.flac?token=1761476352~NDQ0ZDc4OTJlNjE4NmQ4YTc1YWU1ZGJhOTliMDA4NzA1OWE2YjM3Mw== Oct 26 10:59:13 rivoplus-2025 volumio[3536]: STREAMING PROXY: Response: 200, length: 21729843 Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:13 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces state update: player Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: ControllerMpd::getState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:13 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces state update: player Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: ControllerMpd::getState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:13 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces state update: player Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: sendMpdCommand status took 17 milliseconds Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: ControllerMpd::getState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: sendMpdCommand status took 18 milliseconds Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: sendMpdCommand status took 3 milliseconds Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: ControllerMpd::pushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::servicePushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 2 Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":190,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"24577678&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/24577678&soundQuality=LOSSLESS","trackType":"tidal"} Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: CURRENT POSITION 2 Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState stateService play Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState currentStatus stop Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: ------------------------------ 29ms Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Oct 26 10:59:13 rivoplus-2025 volumio[3536]: ---------------------------- MPD announces state update: player Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: ControllerMpd::getState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand status Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: sendMpdCommand status took 2 milliseconds Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: ControllerMpd::pushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::servicePushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 2 Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":190,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"24577678&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/24577678&soundQuality=LOSSLESS","trackType":"tidal"} Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: CURRENT POSITION 2 Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState stateService play Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Received an update from plugin. extracting info from payload Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: ControllerMpd::pushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::servicePushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 2 Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":190,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"24577678&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/24577678&soundQuality=LOSSLESS","trackType":"tidal"} Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: CURRENT POSITION 2 Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState stateService play Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Received an update from plugin. extracting info from payload Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: ------------------------------ 71ms Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: ------------------------------ 58ms Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: sendMpdCommand playlistinfo took 39 milliseconds Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: ControllerMpd::parseTrackInfo Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: ControllerMpd::pushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::servicePushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getTrack 2 Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":190,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"24577678&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/24577678&soundQuality=LOSSLESS","trackType":"tidal"} Oct 26 10:59:13 rivoplus-2025 volumio[3536]: verbose: CURRENT POSITION 2 Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState stateService play Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::syncState currentStatus play Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Received an update from plugin. extracting info from payload Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreStateMachine::pushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioPushState Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: ------------------------------ 77ms Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: Signalling Playback active due to playback status change Oct 26 10:59:13 rivoplus-2025 volumio[3536]: info: MCU Signalled Playback Active Oct 26 10:59:13 rivoplus-2025 volumio[3536]: STREAMING PROXY: Client dropped request, destroying Oct 26 10:59:20 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 26 10:59:20 rivoplus-2025 volumio[3536]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 26 10:59:20 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 26 10:59:20 rivoplus-2025 volumio[3536]: info: Received Get System Version Oct 26 10:59:20 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 26 10:59:20 rivoplus-2025 volumio[3536]: info: Received Get System Info Oct 26 10:59:20 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 10:59:20 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 10:59:20 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 10:59:20 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:20 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 10:59:26 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 10:59:26 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 10:59:26 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 10:59:26 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:26 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 10:59:50 rivoplus-2025 volumiologrotate[2854]: ls: cannot access '/var/log/samba/log.wb-RIVOPLUS': No such file or directory Oct 26 10:59:50 rivoplus-2025 volumiologrotate[2854]: ls: cannot access '2025': No such file or directory Oct 26 10:59:50 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 10:59:50 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 10:59:50 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 10:59:50 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:50 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 10:59:50 rivoplus-2025 volumio[3536]: verbose: New Socket.io Connection to 192.168.1.10:3000 from 192.168.1.12 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Oct 26 10:59:50 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:50 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 26 10:59:50 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 26 10:59:55 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 10:59:55 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 10:59:55 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 10:59:55 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:55 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 10:59:55 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 10:59:55 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 10:59:55 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 10:59:55 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:55 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 10:59:57 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 10:59:59 rivoplus-2025 sudo[4988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 10:59:59 rivoplus-2025 sudo[4988]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 10:59:59 rivoplus-2025 sudo[4988]: pam_unix(sudo:session): session closed for user root Oct 26 10:59:59 rivoplus-2025 sudo[4992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 10:59:59 rivoplus-2025 sudo[4992]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 10:59:59 rivoplus-2025 sudo[4992]: pam_unix(sudo:session): session closed for user root Oct 26 10:59:59 rivoplus-2025 volumio[3536]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.12 UA: Mozilla/5.0 (Linux; Android 15; SM-A546B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 26 11:00:00 rivoplus-2025 sudo[4996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 11:00:00 rivoplus-2025 sudo[4996]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 11:00:00 rivoplus-2025 sudo[4996]: pam_unix(sudo:session): session closed for user root Oct 26 11:00:00 rivoplus-2025 sudo[5000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 11:00:00 rivoplus-2025 sudo[5000]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 11:00:00 rivoplus-2025 sudo[5000]: pam_unix(sudo:session): session closed for user root Oct 26 11:00:00 rivoplus-2025 volumio[3536]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.12 UA: Mozilla/5.0 (Linux; Android 15; SM-A546B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetVisibleSources Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: Received Get System Info Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: Listing playlists Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 26 11:00:01 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 26 11:00:02 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 11:00:02 rivoplus-2025 volumio[3536]: info: Received Get System Info Oct 26 11:00:02 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 11:00:02 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 11:00:02 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 11:00:02 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 11:00:02 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 11:00:02 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 26 11:00:03 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetQueue Oct 26 11:00:03 rivoplus-2025 volumio[3536]: info: CoreStateMachine::getQueue Oct 26 11:00:03 rivoplus-2025 volumio[3536]: info: CorePlayQueue::getQueue Oct 26 11:00:04 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 11:00:04 rivoplus-2025 volumio[3536]: info: Received Get System Info Oct 26 11:00:04 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 11:00:04 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 11:00:04 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 11:00:04 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 11:00:04 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 11:00:10 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 26 11:00:18 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 26 11:00:18 rivoplus-2025 volumio[3536]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 26 11:00:18 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 26 11:00:18 rivoplus-2025 volumio[3536]: info: Received Get System Version Oct 26 11:00:18 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 26 11:00:18 rivoplus-2025 volumio[3536]: info: Received Get System Info Oct 26 11:00:18 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 11:00:18 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 11:00:18 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 11:00:18 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 11:00:18 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 11:00:20 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 11:00:20 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 11:00:20 rivoplus-2025 volumio[3536]: info: Discovery: Getting this device information Oct 26 11:00:20 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::volumioGetState Oct 26 11:00:20 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 11:00:45 rivoplus-2025 volumio[3536]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Oct 26 11:00:45 rivoplus-2025 volumio[3536]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 11:00:45 rivoplus-2025 volumio[3536]: TypeError: Cannot read property 'then' of undefined Oct 26 11:00:45 rivoplus-2025 volumio[3536]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:498:20) Oct 26 11:00:45 rivoplus-2025 volumio[3536]: at Socket.emit (events.js:400:28) Oct 26 11:00:45 rivoplus-2025 volumio[3536]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 26 11:00:45 rivoplus-2025 volumio[3536]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Oct 26 11:00:45 rivoplus-2025 volumio[3536]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 11:00:46 rivoplus-2025 sudo[5105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-26 10:59 Oct 26 11:00:46 rivoplus-2025 sudo[5105]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:23:19 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="ca35d8983c8e34dfa9cca80071cf9105"