-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Tue 2026-01-13 09:12:50 CST. -- Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 09:11:05 volumio-sm volumio[969]: info: Retrieving Cloud Streaming UI Jan 13 09:11:05 volumio-sm volumio[969]: info: Getting Tidal Cloud Configuration Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 09:11:05 volumio-sm volumio[969]: info: Getting Qobuz Cloud Configuration Jan 13 09:11:05 volumio-sm volumio[969]: info: Asking plugin for UI Config Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 09:11:05 volumio-sm volumio[969]: info: Getting Spotify Cloud Configuration Jan 13 09:11:05 volumio-sm volumio[969]: info: Asking plugin for UI Config Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 09:11:05 volumio-sm volumio[969]: info: Saving Spotify Acccount Jan 13 09:11:05 volumio-sm volumio[969]: info: Got Tidal Cloud Configuration Jan 13 09:11:05 volumio-sm volumio[969]: info: Got it Jan 13 09:11:05 volumio-sm volumio[969]: info: Got it Jan 13 09:11:05 volumio-sm volumio[969]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 09:11:05 volumio-sm volumio[969]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::volumioGetBrowseSources Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::volumioGetBrowseSources Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::volumioGetBrowseSources Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:05 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 13 09:11:09 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:13 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:16 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jan 13 09:11:17 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 13 09:11:17 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:21 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:25 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:29 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:33 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:37 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:41 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:45 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:47 volumio-sm volumiologrotate[561]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jan 13 09:11:47 volumio-sm volumiologrotate[561]: ls: cannot access 'SM': No such file or directory Jan 13 09:11:49 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:53 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:11:57 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:12:01 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:12:12 volumio-sm sudo[3758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 13 09:12:12 volumio-sm sudo[3758]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 09:12:12 volumio-sm sudo[3758]: pam_unix(sudo:session): session closed for user root Jan 13 09:12:12 volumio-sm sudo[3761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 13 09:12:12 volumio-sm sudo[3761]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 09:12:12 volumio-sm sudo[3761]: pam_unix(sudo:session): session closed for user root Jan 13 09:12:12 volumio-sm volumio[969]: verbose: New Socket.io Connection to 192.168.0.110 from 192.168.0.103 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.6 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 8 Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::volumioGetVisibleSources Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::volumioGetState Jan 13 09:12:12 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 13 09:12:12 volumio-sm volumio[969]: info: Received Get System Info Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 13 09:12:12 volumio-sm volumio[969]: info: Discovery: Getting this device information Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::volumioGetState Jan 13 09:12:12 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::volumioGetState Jan 13 09:12:12 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:12 volumio-sm volumio[969]: info: Listing playlists Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 13 09:12:12 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 13 09:12:13 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 13 09:12:14 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 13 09:12:14 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 13 09:12:14 volumio-sm volumio[969]: info: Received Get System Info Jan 13 09:12:14 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 13 09:12:14 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 13 09:12:14 volumio-sm volumio[969]: info: Discovery: Getting this device information Jan 13 09:12:14 volumio-sm volumio[969]: info: CoreCommandRouter::volumioGetState Jan 13 09:12:14 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:14 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 13 09:12:17 volumio-sm volumio[969]: info: CoreCommandRouter::volumioGetQueue Jan 13 09:12:17 volumio-sm volumio[969]: info: CoreStateMachine::getQueue Jan 13 09:12:17 volumio-sm volumio[969]: info: CorePlayQueue::getQueue Jan 13 09:12:22 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 09:12:30 volumio-sm volumio[969]: info: Retrieving Cloud Streaming UI Jan 13 09:12:30 volumio-sm volumio[969]: info: Getting Tidal Cloud Configuration Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 09:12:30 volumio-sm volumio[969]: info: Getting Qobuz Cloud Configuration Jan 13 09:12:30 volumio-sm volumio[969]: info: Asking plugin for UI Config Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 09:12:30 volumio-sm volumio[969]: info: Getting Spotify Cloud Configuration Jan 13 09:12:30 volumio-sm volumio[969]: info: Asking plugin for UI Config Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 09:12:30 volumio-sm volumio[969]: info: Saving Spotify Acccount Jan 13 09:12:30 volumio-sm volumio[969]: info: Got Tidal Cloud Configuration Jan 13 09:12:30 volumio-sm volumio[969]: info: Got it Jan 13 09:12:30 volumio-sm volumio[969]: info: Got it Jan 13 09:12:30 volumio-sm volumio[969]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 09:12:30 volumio-sm volumio[969]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::volumioGetBrowseSources Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::volumioGetBrowseSources Jan 13 09:12:30 volumio-sm volumio[969]: info: CoreCommandRouter::volumioGetBrowseSources Jan 13 09:12:31 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:12:31 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 13 09:12:34 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jan 13 09:12:34 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand rescan Jan 13 09:12:34 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:34 volumio-sm volumio[969]: info: Jan 13 09:12:34 volumio-sm volumio[969]: ---------------------------- MPD announces state update: update Jan 13 09:12:34 volumio-sm volumio[969]: info: sendMpdCommand rescan took 7 milliseconds Jan 13 09:12:34 volumio-sm volumio[969]: info: ControllerMpd::getState Jan 13 09:12:34 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:34 volumio-sm volumio[969]: info: sendMpdCommand status took 2 milliseconds Jan 13 09:12:34 volumio-sm volumio[969]: info: sendMpdCommand status took 2 milliseconds Jan 13 09:12:34 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:34 volumio-sm volumio[969]: info: Command Router : Notfying DB Updatetrue Jan 13 09:12:34 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:34 volumio-sm volumio[969]: info: ControllerMpd::pushState Jan 13 09:12:34 volumio-sm volumio[969]: info: CoreCommandRouter::servicePushState Jan 13 09:12:34 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:34 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:34 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 09:12:34 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:34 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:34 volumio-sm volumio[969]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 13 09:12:34 volumio-sm volumio[969]: verbose: CURRENT POSITION 2 Jan 13 09:12:34 volumio-sm volumio[969]: info: CoreStateMachine::syncState stateService stop Jan 13 09:12:34 volumio-sm volumio[969]: info: CoreStateMachine::syncState currentStatus stop Jan 13 09:12:34 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:34 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:34 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 09:12:34 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:34 volumio-sm volumio[969]: info: No code Jan 13 09:12:34 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:34 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:34 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:34 volumio-sm volumio[969]: info: ------------------------------ 159ms Jan 13 09:12:34 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:34 volumio-sm volumio[969]: info: Jan 13 09:12:34 volumio-sm volumio[969]: ---------------------------- MPD announces state update: update Jan 13 09:12:34 volumio-sm volumio[969]: info: ControllerMpd::getState Jan 13 09:12:34 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:34 volumio-sm volumio[969]: info: Jan 13 09:12:34 volumio-sm volumio[969]: ---------------------------- MPD announces state update: update Jan 13 09:12:34 volumio-sm volumio[969]: info: ControllerMpd::getState Jan 13 09:12:34 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:35 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:12:35 volumio-sm volumio[969]: info: CoreCommandRouter::Close All Modals sent Jan 13 09:12:36 volumio-sm volumio[969]: info: MPD Database updated - AlbumList cache refreshed Jan 13 09:12:36 volumio-sm volumio[969]: info: Jan 13 09:12:36 volumio-sm volumio[969]: ---------------------------- MPD announces state update: database Jan 13 09:12:36 volumio-sm volumio[969]: info: Jan 13 09:12:36 volumio-sm volumio[969]: ---------------------------- MPD announces system playlist update Jan 13 09:12:36 volumio-sm volumio[969]: info: Ignoring MPD Status Update Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::getState Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:36 volumio-sm volumio[969]: info: Jan 13 09:12:36 volumio-sm volumio[969]: ---------------------------- MPD announces state update: update Jan 13 09:12:36 volumio-sm volumio[969]: error: updateQueue error: null Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 2023 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::getState Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 2023 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 2021 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 2020 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 7 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: info: ------------------------------ 8ms Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: info: Command Router : Notfying DB Updatefalse Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::Close All Modals sent Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: info: Command Router : Notfying DB Updatefalse Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::Close All Modals sent Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::servicePushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: 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} Jan 13 09:12:36 volumio-sm volumio[969]: verbose: CURRENT POSITION 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState stateService stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState currentStatus stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: No code Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::servicePushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: 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} Jan 13 09:12:36 volumio-sm volumio[969]: verbose: CURRENT POSITION 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState stateService stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState currentStatus stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: No code Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::servicePushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: 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} Jan 13 09:12:36 volumio-sm volumio[969]: verbose: CURRENT POSITION 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState stateService stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState currentStatus stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: No code Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: ------------------------------ 2234ms Jan 13 09:12:36 volumio-sm volumio[969]: info: ------------------------------ 2232ms Jan 13 09:12:36 volumio-sm volumio[969]: info: ------------------------------ 220ms Jan 13 09:12:36 volumio-sm volumio[969]: info: MPD Database updated - AlbumList cache refreshed Jan 13 09:12:36 volumio-sm volumio[969]: info: Jan 13 09:12:36 volumio-sm volumio[969]: ---------------------------- MPD announces state update: database Jan 13 09:12:36 volumio-sm volumio[969]: info: Jan 13 09:12:36 volumio-sm volumio[969]: ---------------------------- MPD announces system playlist update Jan 13 09:12:36 volumio-sm volumio[969]: info: Ignoring MPD Status Update Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:36 volumio-sm volumio[969]: info: Jan 13 09:12:36 volumio-sm volumio[969]: ---------------------------- MPD announces state update: update Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::getState Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::getState Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:36 volumio-sm volumio[969]: info: MPD Database updated - AlbumList cache refreshed Jan 13 09:12:36 volumio-sm volumio[969]: info: Jan 13 09:12:36 volumio-sm volumio[969]: ---------------------------- MPD announces state update: database Jan 13 09:12:36 volumio-sm volumio[969]: info: Jan 13 09:12:36 volumio-sm volumio[969]: ---------------------------- MPD announces system playlist update Jan 13 09:12:36 volumio-sm volumio[969]: info: Ignoring MPD Status Update Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:36 volumio-sm volumio[969]: info: Jan 13 09:12:36 volumio-sm volumio[969]: ---------------------------- MPD announces state update: update Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::getState Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::getState Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::sendMpdCommand status Jan 13 09:12:36 volumio-sm volumio[969]: error: updateQueue error: null Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 238 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 233 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 18 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 16 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: info: ------------------------------ 19ms Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: info: Command Router : Notfying DB Updatefalse Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::Close All Modals sent Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: info: Command Router : Notfying DB Updatefalse Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::Close All Modals sent Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::servicePushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: 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} Jan 13 09:12:36 volumio-sm volumio[969]: verbose: CURRENT POSITION 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState stateService stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState currentStatus stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: No code Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::servicePushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: 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} Jan 13 09:12:36 volumio-sm volumio[969]: verbose: CURRENT POSITION 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState stateService stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState currentStatus stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: No code Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: ------------------------------ 365ms Jan 13 09:12:36 volumio-sm volumio[969]: info: ------------------------------ 146ms Jan 13 09:12:36 volumio-sm volumio[969]: error: Upnp client error: Error: This socket has been ended by the other party Jan 13 09:12:36 volumio-sm volumio[969]: error: updateQueue error: null Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 198 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 189 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 188 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: info: ------------------------------ 190ms Jan 13 09:12:36 volumio-sm volumio[969]: info: sendMpdCommand status took 188 milliseconds Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: info: Command Router : Notfying DB Updatefalse Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::Close All Modals sent Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: verbose: ControllerMpd::parseState Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::servicePushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: 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} Jan 13 09:12:36 volumio-sm volumio[969]: verbose: CURRENT POSITION 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState stateService stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState currentStatus stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: No code Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::servicePushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: 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} Jan 13 09:12:36 volumio-sm volumio[969]: verbose: CURRENT POSITION 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState stateService stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState currentStatus stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: No code Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: ControllerMpd::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::servicePushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: 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} Jan 13 09:12:36 volumio-sm volumio[969]: verbose: CURRENT POSITION 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState stateService stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::syncState currentStatus stop Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: No code Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreStateMachine::pushState Jan 13 09:12:36 volumio-sm volumio[969]: info: CorePlayQueue::getTrack 2 Jan 13 09:12:36 volumio-sm volumio[969]: info: CoreCommandRouter::volumioPushState Jan 13 09:12:36 volumio-sm volumio[969]: info: ------------------------------ 281ms Jan 13 09:12:36 volumio-sm volumio[969]: info: ------------------------------ 321ms Jan 13 09:12:36 volumio-sm volumio[969]: info: ------------------------------ 321ms Jan 13 09:12:39 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:12:43 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:12:44 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jan 13 09:12:44 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jan 13 09:12:45 volumio-sm volumio[969]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L volumio-dr.local. -m SMB3_11 Jan 13 09:12:45 volumio-sm volumio[969]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L wdnas-106.local. -m SMB3_11 Jan 13 09:12:47 volumio-sm volumio[969]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 09:12:47 volumio-sm volumiologrotate[561]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jan 13 09:12:47 volumio-sm volumiologrotate[561]: ls: cannot access 'SM': No such file or directory Jan 13 09:12:48 volumio-sm ntpd[786]: 193.182.111.142 local addr 192.168.0.110 -> Jan 13 09:12:49 volumio-sm volumio[969]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 09:12:49 volumio-sm volumio[969]: Error: dns service error: unknown Jan 13 09:12:49 volumio-sm volumio[969]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Jan 13 09:12:49 volumio-sm volumio[969]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jan 13 09:12:49 volumio-sm volumio[969]: errorCode: -65537 Jan 13 09:12:49 volumio-sm volumio[969]: } Jan 13 09:12:49 volumio-sm volumio[969]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 09:12:50 volumio-sm sudo[3912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-13 09:11 Jan 13 09:12:50 volumio-sm sudo[3912]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"