-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Fri 2026-02-06 21:53:40 MSK. -- Feb 06 21:53:09 volumio volumio[823]: verbose: New Socket.io Connection to 192.168.0.150:3000 from 192.168.0.113 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 21:53:09 volumio volumio[823]: info: Discovery: Getting this device information Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::volumioGetState Feb 06 21:53:09 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 21:53:09 volumio volumio[823]: info: Discovery: Getting this device information Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::volumioGetState Feb 06 21:53:09 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Feb 06 21:53:09 volumio sudo[17525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Feb 06 21:53:09 volumio sudo[17525]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 21:53:09 volumio sudo[17525]: pam_unix(sudo:session): session closed for user root Feb 06 21:53:09 volumio sudo[17530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 06 21:53:09 volumio sudo[17530]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 21:53:09 volumio sudo[17530]: pam_unix(sudo:session): session closed for user root Feb 06 21:53:09 volumio sudo[17539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 06 21:53:09 volumio sudo[17539]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 21:53:09 volumio sudo[17539]: pam_unix(sudo:session): session closed for user root Feb 06 21:53:09 volumio sudo[17544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 06 21:53:09 volumio sudo[17544]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 21:53:09 volumio sudo[17544]: pam_unix(sudo:session): session closed for user root Feb 06 21:53:09 volumio sudo[17550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 06 21:53:09 volumio sudo[17550]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 21:53:09 volumio sudo[17550]: pam_unix(sudo:session): session closed for user root Feb 06 21:53:09 volumio sudo[17554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 06 21:53:09 volumio sudo[17554]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 21:53:09 volumio sudo[17554]: pam_unix(sudo:session): session closed for user root Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 21:53:09 volumio volumio[823]: info: Discovery: Getting this device information Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::volumioGetState Feb 06 21:53:09 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 21:53:09 volumio volumio[823]: info: Discovery: Getting this device information Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::volumioGetState Feb 06 21:53:09 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::volumioGetState Feb 06 21:53:09 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:09 volumio volumio[823]: verbose: New Socket.io Connection to 192.168.0.150:3000 from 192.168.0.113 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 21:53:09 volumio volumio[823]: info: Discovery: Getting this device information Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::volumioGetState Feb 06 21:53:09 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 21:53:09 volumio volumio[823]: verbose: New Socket.io Connection to 192.168.0.150:3000 from 192.168.0.113 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 06 21:53:09 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 06 21:53:11 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 06 21:53:11 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 06 21:53:12 volumio sudo[17613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 06 21:53:12 volumio sudo[17613]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 21:53:12 volumio sudo[17613]: pam_unix(sudo:session): session closed for user root Feb 06 21:53:12 volumio sudo[17615]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 06 21:53:12 volumio sudo[17615]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 21:53:12 volumio sudo[17615]: pam_unix(sudo:session): session closed for user root Feb 06 21:53:12 volumio volumio[823]: verbose: New Socket.io Connection to 192.168.0.150 from 192.168.0.113 UA: Mozilla/5.0 (Linux; Android 15; RMX3890 Build/AQ3A.240812.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::volumioGetVisibleSources Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::volumioGetState Feb 06 21:53:13 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 06 21:53:13 volumio sudo[17619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 06 21:53:13 volumio sudo[17619]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 21:53:13 volumio sudo[17619]: pam_unix(sudo:session): session closed for user root Feb 06 21:53:13 volumio sudo[17622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 06 21:53:13 volumio sudo[17622]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 21:53:13 volumio sudo[17622]: pam_unix(sudo:session): session closed for user root Feb 06 21:53:13 volumio volumio[823]: verbose: New Socket.io Connection to 192.168.0.150 from 192.168.0.113 UA: Mozilla/5.0 (Linux; Android 15; RMX3890 Build/AQ3A.240812.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::volumioGetState Feb 06 21:53:13 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 06 21:53:13 volumio volumio[823]: info: Listing playlists Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 06 21:53:13 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 06 21:53:16 volumio volumio[823]: info: CoreCommandRouter::volumioGetQueue Feb 06 21:53:16 volumio volumio[823]: info: CoreStateMachine::getQueue Feb 06 21:53:16 volumio volumio[823]: info: CorePlayQueue::getQueue Feb 06 21:53:16 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 21:53:16 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 21:53:16 volumio volumio[823]: info: Discovery: Getting this device information Feb 06 21:53:16 volumio volumio[823]: info: CoreCommandRouter::volumioGetState Feb 06 21:53:16 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:16 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 21:53:16 volumio volumio[823]: verbose: New Socket.io Connection to 192.168.0.150:3000 from 192.168.0.113 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 06 21:53:16 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 06 21:53:16 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 06 21:53:18 volumio nmbd[753]: [2026/02/06 21:53:18.750853, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Feb 06 21:53:18 volumio nmbd[753]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.150 for name WORKGROUP<1d>. Feb 06 21:53:18 volumio nmbd[753]: This response was from IP 192.168.0.126, reporting an IP address of 192.168.0.126. Feb 06 21:53:19 volumio nmbd[753]: [2026/02/06 21:53:19.174928, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Feb 06 21:53:19 volumio nmbd[753]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.0.150 for name WORKGROUP<1d>. Feb 06 21:53:19 volumio nmbd[753]: This response was from IP 192.168.0.155, reporting an IP address of 0.0.0.0. Feb 06 21:53:19 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 06 21:53:19 volumio volumio[823]: info: Received Get System Info Feb 06 21:53:19 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 21:53:19 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 21:53:19 volumio volumio[823]: info: Discovery: Getting this device information Feb 06 21:53:19 volumio volumio[823]: info: CoreCommandRouter::volumioGetState Feb 06 21:53:19 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:19 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 21:53:19 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 06 21:53:20 volumio volumio[823]: Invalid card number. Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 06 21:53:20 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 06 21:53:22 volumio volumio[823]: info: Retrieving Cloud Streaming UI Feb 06 21:53:22 volumio volumio[823]: info: Getting Tidal Cloud Configuration Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 06 21:53:22 volumio volumio[823]: info: Getting Qobuz Cloud Configuration Feb 06 21:53:22 volumio volumio[823]: info: Asking plugin for UI Config Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 06 21:53:22 volumio volumio[823]: info: Getting Spotify Cloud Configuration Feb 06 21:53:22 volumio volumio[823]: info: Asking plugin for UI Config Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 06 21:53:22 volumio volumio[823]: info: Saving Spotify Acccount Feb 06 21:53:22 volumio volumio[823]: info: Got Tidal Cloud Configuration Feb 06 21:53:22 volumio volumio[823]: info: Got it Feb 06 21:53:22 volumio volumio[823]: info: Got it Feb 06 21:53:22 volumio volumio[823]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 06 21:53:22 volumio volumio[823]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::volumioGetBrowseSources Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::volumioGetBrowseSources Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::volumioGetBrowseSources Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 06 21:53:22 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand update Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: Feb 06 21:53:26 volumio volumio[823]: ---------------------------- MPD announces state update: update Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand update took 6 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 6 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 3 milliseconds Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: info: Command Router : Notfying DB Updatetrue Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: 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} Feb 06 21:53:26 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: No code Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: ------------------------------ 84ms Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: Feb 06 21:53:26 volumio volumio[823]: ---------------------------- MPD announces state update: update Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: Feb 06 21:53:26 volumio volumio[823]: ---------------------------- MPD announces state update: update Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: MPD Database updated - AlbumList cache refreshed Feb 06 21:53:26 volumio volumio[823]: info: Feb 06 21:53:26 volumio volumio[823]: ---------------------------- MPD announces state update: database Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: Feb 06 21:53:26 volumio volumio[823]: ---------------------------- MPD announces state update: update Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 10 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 9 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 8 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 8 milliseconds Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: info: Command Router : Notfying DB Updatefalse Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: info: Command Router : Notfying DB Updatefalse Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: 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 06 21:53:26 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: No code Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: 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 06 21:53:26 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: No code Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: ------------------------------ 89ms Feb 06 21:53:26 volumio volumio[823]: info: ------------------------------ 88ms Feb 06 21:53:26 volumio volumio[823]: info: MPD Database updated - AlbumList cache refreshed Feb 06 21:53:26 volumio volumio[823]: info: Feb 06 21:53:26 volumio volumio[823]: ---------------------------- MPD announces state update: database Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: Feb 06 21:53:26 volumio volumio[823]: ---------------------------- MPD announces state update: update Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: MPD Database updated - AlbumList cache refreshed Feb 06 21:53:26 volumio volumio[823]: info: Feb 06 21:53:26 volumio volumio[823]: ---------------------------- MPD announces state update: database Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: Feb 06 21:53:26 volumio volumio[823]: ---------------------------- MPD announces state update: update Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 116 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 115 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 115 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 32 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 32 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 31 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 29 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 23 milliseconds Feb 06 21:53:26 volumio volumio[823]: info: sendMpdCommand status took 24 milliseconds Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: info: Command Router : Notfying DB Updatefalse Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: info: Command Router : Notfying DB Updatefalse Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: info: Command Router : Notfying DB Updatefalse Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: 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 06 21:53:26 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: No code Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: 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 06 21:53:26 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: No code Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: 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 06 21:53:26 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: No code Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: 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 06 21:53:26 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: No code Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: 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 06 21:53:26 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: No code Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: 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 06 21:53:26 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: No code Feb 06 21:53:26 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:26 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:26 volumio volumio[823]: info: ------------------------------ 271ms Feb 06 21:53:26 volumio volumio[823]: info: ------------------------------ 272ms Feb 06 21:53:26 volumio volumio[823]: info: ------------------------------ 188ms Feb 06 21:53:26 volumio volumio[823]: info: ------------------------------ 188ms Feb 06 21:53:26 volumio volumio[823]: info: ------------------------------ 186ms Feb 06 21:53:26 volumio volumio[823]: info: ------------------------------ 187ms Feb 06 21:53:26 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 06 21:53:30 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 06 21:53:31 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 06 21:53:31 volumio volumio[823]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 06 21:53:31 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 06 21:53:31 volumio volumio[823]: info: Received Get System Version Feb 06 21:53:31 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 06 21:53:31 volumio volumio[823]: info: Received Get System Info Feb 06 21:53:31 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 21:53:31 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 21:53:31 volumio volumio[823]: info: Discovery: Getting this device information Feb 06 21:53:31 volumio volumio[823]: info: CoreCommandRouter::volumioGetState Feb 06 21:53:31 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:31 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand rescan Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:34 volumio volumio[823]: info: Feb 06 21:53:34 volumio volumio[823]: ---------------------------- MPD announces state update: update Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand rescan took 3 milliseconds Feb 06 21:53:34 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:34 volumio volumio[823]: info: Feb 06 21:53:34 volumio volumio[823]: ---------------------------- MPD announces state update: update Feb 06 21:53:34 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:34 volumio volumio[823]: info: Feb 06 21:53:34 volumio volumio[823]: ---------------------------- MPD announces state update: update Feb 06 21:53:34 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:34 volumio volumio[823]: info: Feb 06 21:53:34 volumio volumio[823]: ---------------------------- MPD announces state update: update Feb 06 21:53:34 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand status took 8 milliseconds Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand status took 6 milliseconds Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand status took 6 milliseconds Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand status took 6 milliseconds Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand status took 5 milliseconds Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand status took 4 milliseconds Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:34 volumio volumio[823]: info: Command Router : Notfying DB Updatefalse Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:34 volumio volumio[823]: info: Command Router : Notfying DB Updatefalse Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:34 volumio volumio[823]: info: Command Router : Notfying DB Updatefalse Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:34 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: 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 06 21:53:34 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: No code Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: 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 06 21:53:34 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: No code Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: 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 06 21:53:34 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: No code Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: ------------------------------ 132ms Feb 06 21:53:34 volumio volumio[823]: info: ------------------------------ 130ms Feb 06 21:53:34 volumio volumio[823]: info: ------------------------------ 130ms Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:34 volumio volumio[823]: info: Feb 06 21:53:34 volumio volumio[823]: ---------------------------- MPD announces state update: update Feb 06 21:53:34 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:34 volumio volumio[823]: info: Feb 06 21:53:34 volumio volumio[823]: ---------------------------- MPD announces state update: update Feb 06 21:53:34 volumio volumio[823]: info: ControllerMpd::getState Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::sendMpdCommand status Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand status took 134 milliseconds Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand status took 133 milliseconds Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand status took 5 milliseconds Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand status took 4 milliseconds Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand status took 3 milliseconds Feb 06 21:53:34 volumio volumio[823]: info: sendMpdCommand status took 3 milliseconds Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:34 volumio volumio[823]: info: Command Router : Notfying DB Updatefalse Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:34 volumio volumio[823]: info: Command Router : Notfying DB Updatefalse Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:34 volumio volumio[823]: info: Command Router : Notfying DB Updatefalse Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Feb 06 21:53:34 volumio volumio[823]: verbose: ControllerMpd::parseState Feb 06 21:53:34 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: 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 06 21:53:34 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: No code Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: 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 06 21:53:34 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: No code Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: ControllerMpd::pushState Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::servicePushState Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: 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 06 21:53:34 volumio volumio[823]: verbose: CURRENT POSITION 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::syncState stateService stop Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::syncState currentStatus stop Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: No code Feb 06 21:53:34 volumio volumio[823]: info: CoreStateMachine::pushState Feb 06 21:53:34 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Feb 06 21:53:34 volumio volumio[823]: info: ------------------------------ 252ms Feb 06 21:53:34 volumio volumio[823]: info: ------------------------------ 122ms Feb 06 21:53:34 volumio volumio[823]: info: ------------------------------ 121ms Feb 06 21:53:34 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 06 21:53:38 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 06 21:53:39 volumio volumio[823]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 06 21:53:39 volumio volumio[823]: [t [Error]: A network error (such as timeout, interrupted connection or unreachable host) has occurred.] { Feb 06 21:53:39 volumio volumio[823]: code: 'auth/network-request-failed', Feb 06 21:53:39 volumio volumio[823]: a: null Feb 06 21:53:39 volumio volumio[823]: } Feb 06 21:53:39 volumio volumio[823]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 06 21:53:40 volumio sudo[17704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-06 21:52 Feb 06 21:53:40 volumio sudo[17704]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"