Feb 17 09:31:09 volumio-rpi4 systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Feb 17 09:31:10 volumio-rpi4 systemd[1]: setdatetime-helper.service: Deactivated successfully. Feb 17 09:31:10 volumio-rpi4 systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Feb 17 09:31:21 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPlay Feb 17 09:31:21 volumio-rpi4 volumio[1514]: info: CoreStateMachine::play index undefined Feb 17 09:31:21 volumio-rpi4 volumio[1514]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:31:21 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:31:21 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPlay Feb 17 09:31:21 volumio-rpi4 volumio[1514]: info: CoreStateMachine::play index undefined Feb 17 09:31:21 volumio-rpi4 volumio[1514]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:31:21 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Preload queue cleared Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::ClearQueue Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::stop Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CorePlayQueue::clearPlayQueue Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CorePlayQueue::saveQueue Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushQueue Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::addQueueItems Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CorePlayQueue::addQueueItems Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Preload queue cleared Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/18 Peter Gabriel - Come Talk to Me.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/18 Peter Gabriel - Come Talk to Me.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/01 Peter Gabriel - Jetzt kommt die Flut.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/01 Peter Gabriel - Jetzt kommt die Flut.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/02 Peter Gabriel - Darkness.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/02 Peter Gabriel - Darkness.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/03 Peter Gabriel - Red Rain.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/03 Peter Gabriel - Red Rain.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/04 Peter Gabriel - Secret World.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/04 Peter Gabriel - Secret World.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushQueue Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CorePlayQueue::saveQueue Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::updateTrackBlock Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrackBlock Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPlay Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::play index 4 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::addQueueItems Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CorePlayQueue::addQueueItems Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Preload queue cleared Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/05 Peter Gabriel - White Ashes.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/05 Peter Gabriel - White Ashes.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/06 Peter Gabriel - Games Without Frontiers.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/06 Peter Gabriel - Games Without Frontiers.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/07 Peter Gabriel - Burn You Up, Burn You Down.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/07 Peter Gabriel - Burn You Up, Burn You Down.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/08 Peter Gabriel - Downside Up.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/08 Peter Gabriel - Downside Up.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/09 Peter Gabriel - The Tower That Ate People.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/09 Peter Gabriel - The Tower That Ate People.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/10 Peter Gabriel - More Than This.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/10 Peter Gabriel - More Than This.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/11 Peter Gabriel - San Jacinto.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/11 Peter Gabriel - San Jacinto.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/12 Peter Gabriel - Digging In The Dirt.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/12 Peter Gabriel - Digging In The Dirt.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/13 Peter Gabriel - Growing Up.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/13 Peter Gabriel - Growing Up.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/14 Peter Gabriel - Solsbury Hill.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/14 Peter Gabriel - Solsbury Hill.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/15 Peter Gabriel - Sledgehammer.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/15 Peter Gabriel - Sledgehammer.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/16 Peter Gabriel - Signal To Noise.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/16 Peter Gabriel - Signal To Noise.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/17 Peter Gabriel - In Your Eyes.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/17 Peter Gabriel - In Your Eyes.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Adding Item to queue: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/19 Peter Gabriel - Father, Son.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: Using cached record of: music-library/NAS/raspi4-lms/Peter Gabriel/Live in Hamburg 2004/19 Peter Gabriel - Father, Son.mp3 Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::stop Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushQueue Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CorePlayQueue::saveQueue Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::play index undefined Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CoreStateMachine::updateTrackBlock Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrackBlock Feb 17 09:31:29 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 4 Feb 17 09:31:33 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPlay Feb 17 09:31:33 volumio-rpi4 volumio[1514]: info: CoreStateMachine::play index undefined Feb 17 09:31:33 volumio-rpi4 volumio[1514]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:31:33 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:31:46 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPlay Feb 17 09:31:46 volumio-rpi4 volumio[1514]: info: CoreStateMachine::play index undefined Feb 17 09:31:46 volumio-rpi4 volumio[1514]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:31:46 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: Retrieving Cloud Streaming UI Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: Getting Tidal Cloud Configuration Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: Getting Qobuz Cloud Configuration Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: Asking plugin for UI Config Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: Getting Spotify Cloud Configuration Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: Asking plugin for UI Config Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: Saving Spotify Acccount Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: Got Tidal Cloud Configuration Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: Got it Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: Got it Feb 17 09:31:50 volumio-rpi4 volumio[1514]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 09:31:50 volumio-rpi4 volumio[1514]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioGetBrowseSources Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioGetBrowseSources Feb 17 09:31:50 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioGetBrowseSources Feb 17 09:31:51 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:31:51 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 17 09:31:55 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:31:59 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:03 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:07 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:11 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:12 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Feb 17 09:32:12 volumio-rpi4 volumio[1514]: info: Share raspi4-lms successfully unmounted Feb 17 09:32:12 volumio-rpi4 sudo[22008]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=rpi4-lms-smb,password=brettermeier,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //192.168.2.221/rpi4-lms-music /mnt/NAS/raspi4-lms Feb 17 09:32:12 volumio-rpi4 sudo[22008]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 09:32:12 volumio-rpi4 kernel: CIFS: Attempting to mount //192.168.2.221/rpi4-lms-music Feb 17 09:32:12 volumio-rpi4 sudo[22008]: pam_unix(sudo:session): session closed for user root Feb 17 09:32:12 volumio-rpi4 kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Feb 17 09:32:12 volumio-rpi4 volumio[1514]: info: An error occurred mounting the new share. Rolling back configuration Feb 17 09:32:13 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 17 09:32:15 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:19 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:23 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:27 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:30 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Feb 17 09:32:31 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:32 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 17 09:32:35 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:39 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand rescan Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: Feb 17 09:32:41 volumio-rpi4 volumio[1514]: ---------------------------- MPD announces state update: update Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: sendMpdCommand rescan took 3 milliseconds Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: ControllerMpd::getState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: Feb 17 09:32:41 volumio-rpi4 volumio[1514]: ---------------------------- MPD announces state update: update Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: ControllerMpd::getState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: Feb 17 09:32:41 volumio-rpi4 volumio[1514]: ---------------------------- MPD announces state update: update Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: ControllerMpd::getState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 5 milliseconds Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 4 milliseconds Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 5 milliseconds Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 4 milliseconds Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: Command Router : Notfying DB Updatetrue Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: Command Router : Notfying DB Updatetrue Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::Close All Modals sent Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 80 milliseconds Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 79 milliseconds Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: Command Router : Notfying DB Updatetrue Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::Close All Modals sent Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: sendMpdCommand playlistinfo took 54 milliseconds Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: sendMpdCommand playlistinfo took 36 milliseconds Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: ControllerMpd::pushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::servicePushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come Talk to Me","artist":"Peter Gabriel","album":"Live","uri":"NAS/raspi4-lms/Peter Gabriel/Secret World Live (1994)/01 Peter Gabriel - Come Talk to Me.mp3","trackType":"mp3"} Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: CURRENT POSITION 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState stateService stop Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState currentStatus stop Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: No code Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: ControllerMpd::pushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::servicePushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come Talk to Me","artist":"Peter Gabriel","album":"Live","uri":"NAS/raspi4-lms/Peter Gabriel/Secret World Live (1994)/01 Peter Gabriel - Come Talk to Me.mp3","trackType":"mp3"} Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: CURRENT POSITION 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState stateService stop Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState currentStatus stop Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: No code Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: ControllerMpd::pushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::servicePushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come Talk to Me","artist":"Peter Gabriel","album":"Live","uri":"NAS/raspi4-lms/Peter Gabriel/Secret World Live (1994)/01 Peter Gabriel - Come Talk to Me.mp3","trackType":"mp3"} Feb 17 09:32:41 volumio-rpi4 volumio[1514]: verbose: CURRENT POSITION 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState stateService stop Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState currentStatus stop Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: No code Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: ------------------------------ 153ms Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: ------------------------------ 152ms Feb 17 09:32:41 volumio-rpi4 volumio[1514]: info: ------------------------------ 152ms Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: MPD Database updated - AlbumList cache refreshed Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Feb 17 09:32:42 volumio-rpi4 volumio[1514]: ---------------------------- MPD announces state update: database Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Feb 17 09:32:42 volumio-rpi4 volumio[1514]: ---------------------------- MPD announces system playlist update Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Ignoring MPD Status Update Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ControllerMpd::getState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: MPD Database updated - AlbumList cache refreshed Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Feb 17 09:32:42 volumio-rpi4 volumio[1514]: ---------------------------- MPD announces state update: database Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Feb 17 09:32:42 volumio-rpi4 volumio[1514]: ---------------------------- MPD announces system playlist update Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Ignoring MPD Status Update Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ControllerMpd::getState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: MPD Database updated - AlbumList cache refreshed Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Feb 17 09:32:42 volumio-rpi4 volumio[1514]: ---------------------------- MPD announces state update: database Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Feb 17 09:32:42 volumio-rpi4 volumio[1514]: ---------------------------- MPD announces system playlist update Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Ignoring MPD Status Update Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Feb 17 09:32:42 volumio-rpi4 volumio[1514]: ---------------------------- MPD announces state update: update Feb 17 09:32:42 volumio-rpi4 volumio[1514]: error: updateQueue error: null Feb 17 09:32:42 volumio-rpi4 volumio[1514]: error: updateQueue error: null Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ControllerMpd::getState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ControllerMpd::getState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 17 milliseconds Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ------------------------------ 18ms Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 12 milliseconds Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ------------------------------ 16ms Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ControllerMpd::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::servicePushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: 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} Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: CURRENT POSITION 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState stateService stop Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState currentStatus stop Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: No code Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ControllerMpd::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::servicePushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: 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} Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: CURRENT POSITION 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState stateService stop Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState currentStatus stop Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: No code Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ------------------------------ 60ms Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ------------------------------ 59ms Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Feb 17 09:32:42 volumio-rpi4 volumio[1514]: ---------------------------- MPD announces state update: update Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ControllerMpd::getState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Feb 17 09:32:42 volumio-rpi4 volumio[1514]: ---------------------------- MPD announces state update: update Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ControllerMpd::getState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:32:42 volumio-rpi4 volumio[1514]: error: updateQueue error: null Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 57 milliseconds Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 51 milliseconds Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ------------------------------ 60ms Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 50 milliseconds Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 6 milliseconds Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 5 milliseconds Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 4 milliseconds Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Command Router : Notfying DB Updatefalse Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::Close All Modals sent Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Command Router : Notfying DB Updatefalse Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::Close All Modals sent Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: Command Router : Notfying DB Updatefalse Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::Close All Modals sent Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ControllerMpd::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::servicePushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: 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} Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: CURRENT POSITION 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState stateService stop Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState currentStatus stop Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: No code Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ControllerMpd::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::servicePushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: 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} Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: CURRENT POSITION 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState stateService stop Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState currentStatus stop Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: No code Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ControllerMpd::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::servicePushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: 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} Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: CURRENT POSITION 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState stateService stop Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState currentStatus stop Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: No code Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ------------------------------ 193ms Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ------------------------------ 192ms Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ------------------------------ 140ms Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: sendMpdCommand status took 163 milliseconds Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: ControllerMpd::parseState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ControllerMpd::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::servicePushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: 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} Feb 17 09:32:42 volumio-rpi4 volumio[1514]: verbose: CURRENT POSITION 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState stateService stop Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::syncState currentStatus stop Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: No code Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreStateMachine::pushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CorePlayQueue::getTrack 0 Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::volumioPushState Feb 17 09:32:42 volumio-rpi4 volumio[1514]: info: ------------------------------ 174ms Feb 17 09:32:43 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:47 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 09:32:49 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Feb 17 09:32:49 volumio-rpi4 volumio[1514]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Feb 17 09:32:49 volumio-rpi4 volumio[1514]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 09:32:49 volumio-rpi4 volumio[1514]: Error: dns service error: unknown Feb 17 09:32:49 volumio-rpi4 volumio[1514]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Feb 17 09:32:49 volumio-rpi4 volumio[1514]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Feb 17 09:32:49 volumio-rpi4 volumio[1514]: errorCode: -65537 Feb 17 09:32:49 volumio-rpi4 volumio[1514]: } Feb 17 09:32:49 volumio-rpi4 volumio[1514]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 09:32:50 volumio-rpi4 sudo[22142]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-17 09:31' Feb 17 09:32:50 volumio-rpi4 sudo[22142]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"