-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Tue 2026-02-10 18:34:17 GMT. -- Feb 10 18:33:00 volumio-bedroom volumio[1164]: ........................................................++++ Feb 10 18:33:05 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 10 18:33:05 volumio-bedroom volumio[961]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Feb 10 18:33:05 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioGetState Feb 10 18:33:05 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:08 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 18:33:08 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 18:33:08 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 10 18:33:08 volumio-bedroom volumio-remote-updater[561]: No test mode Feb 10 18:33:08 volumio-bedroom volumio-remote-updater[561]: No alpha test mode Feb 10 18:33:08 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 10 18:33:08 volumio-bedroom volumio[961]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

 

NEW ADDITIONS

 

","title":"Update v3.908","updateavailable":true} Feb 10 18:33:08 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 10 18:33:10 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 18:33:10 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 18:33:10 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 10 18:33:10 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 10 18:33:10 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 10 18:33:10 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 10 18:33:10 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioGetBrowseSources Feb 10 18:33:10 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 10 18:33:11 volumio-bedroom volumio[1164]: ...............................................................................................++++ Feb 10 18:33:11 volumio-bedroom volumio[1164]: e is 65537 (0x010001) Feb 10 18:33:11 volumio-bedroom volumio[1164]: writing RSA key Feb 10 18:33:12 volumio-bedroom volumio[961]: error: MyVolumio Plugin failed to authenticate in a timely fashion Feb 10 18:33:12 volumio-bedroom volumio[961]: info: Completed starting MyVolumio Plugin Feb 10 18:33:12 volumio-bedroom volumio[961]: [Metrics] CommandRouter: 70s 134.56ms Feb 10 18:33:12 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumiosetStartupVolume Feb 10 18:33:12 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 10 18:33:12 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 10 18:33:12 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:33:12 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:33:13 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 10 18:33:13 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 10 18:33:13 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 10 18:33:19 volumio-bedroom volumio[961]: info: BOOT COMPLETED Feb 10 18:33:44 volumio-bedroom volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 10 18:33:44 volumio-bedroom volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 10 18:33:44 volumio-bedroom volumio[961]: info: Retrieving Cloud Streaming UI Feb 10 18:33:44 volumio-bedroom volumio[961]: info: Getting Tidal Cloud Configuration Feb 10 18:33:44 volumio-bedroom volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 10 18:33:44 volumio-bedroom volumio[961]: info: Getting Qobuz Cloud Configuration Feb 10 18:33:44 volumio-bedroom volumio[961]: info: Asking plugin for UI Config Feb 10 18:33:44 volumio-bedroom volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 10 18:33:44 volumio-bedroom volumio[961]: info: Getting Spotify Cloud Configuration Feb 10 18:33:44 volumio-bedroom volumio[961]: info: Asking plugin for UI Config Feb 10 18:33:44 volumio-bedroom volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 10 18:33:44 volumio-bedroom volumio[961]: info: Saving Spotify Acccount Feb 10 18:33:44 volumio-bedroom volumio[961]: info: Got Tidal Cloud Configuration Feb 10 18:33:44 volumio-bedroom volumio[961]: info: Got it Feb 10 18:33:44 volumio-bedroom volumio[961]: info: Got it Feb 10 18:33:44 volumio-bedroom volumio[961]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 10 18:33:45 volumio-bedroom volumio[961]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioGetBrowseSources Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioGetBrowseSources Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioGetBrowseSources Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 10 18:33:45 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 10 18:33:49 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 10 18:33:51 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Feb 10 18:33:52 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 10 18:33:53 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 10 18:33:55 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Feb 10 18:33:55 volumio-bedroom sudo[1536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Music Feb 10 18:33:55 volumio-bedroom sudo[1536]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 10 18:33:55 volumio-bedroom systemd[1]: mnt-NAS-Music.mount: Succeeded. Feb 10 18:33:55 volumio-bedroom sudo[1536]: pam_unix(sudo:session): session closed for user root Feb 10 18:33:55 volumio-bedroom volumio[961]: info: Share Music successfully unmounted Feb 10 18:33:56 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 10 18:33:57 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Feb 10 18:33:58 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: update Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Feb 10 18:33:58 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: update Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 10 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 7 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 5 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Command Router : Notfying DB Updatetrue Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Command Router : Notfying DB Updatetrue Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: 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 10 18:33:58 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: No code Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: 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 10 18:33:58 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: No code Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ------------------------------ 160ms Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ------------------------------ 157ms Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Feb 10 18:33:58 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: update Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: [1770748438440] Database update started Feb 10 18:33:58 volumio-bedroom volumio[961]: info: MPD Database updated - AlbumList cache refreshed Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Feb 10 18:33:58 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: database Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Feb 10 18:33:58 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: update Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 18 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 16 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Command Router : Notfying DB Updatefalse Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: 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 10 18:33:58 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: No code Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ------------------------------ 77ms Feb 10 18:33:58 volumio-bedroom volumio[961]: info: MPD Database updated - AlbumList cache refreshed Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Feb 10 18:33:58 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: database Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Feb 10 18:33:58 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: update Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: MPD Database updated - AlbumList cache refreshed Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Feb 10 18:33:58 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: database Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Feb 10 18:33:58 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: update Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 98 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 97 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 95 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 35 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 33 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 34 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 16 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 15 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: info: sendMpdCommand status took 15 milliseconds Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Command Router : Notfying DB Updatefalse Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Command Router : Notfying DB Updatefalse Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: Command Router : Notfying DB Updatefalse Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: 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 10 18:33:58 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: No code Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: 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 10 18:33:58 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: No code Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: 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 10 18:33:58 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: No code Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: 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 10 18:33:58 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: No code Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: 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 10 18:33:58 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: No code Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: 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 10 18:33:58 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: No code Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:33:58 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ------------------------------ 342ms Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ------------------------------ 344ms Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ------------------------------ 280ms Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ------------------------------ 282ms Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ------------------------------ 263ms Feb 10 18:33:58 volumio-bedroom volumio[961]: info: ------------------------------ 264ms Feb 10 18:34:01 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand rescan Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:34:04 volumio-bedroom volumio[961]: info: Feb 10 18:34:04 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: update Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand rescan took 12 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:34:04 volumio-bedroom volumio[961]: info: Feb 10 18:34:04 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: update Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand status took 14 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand status took 4 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: Command Router : Notfying DB Updatefalse Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: 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 10 18:34:04 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: No code Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ------------------------------ 75ms Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:34:04 volumio-bedroom volumio[961]: info: Feb 10 18:34:04 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: update Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:34:04 volumio-bedroom volumio[961]: info: Feb 10 18:34:04 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: update Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand status took 69 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand status took 68 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand status took 6 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand status took 4 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand status took 4 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand status took 3 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: Command Router : Notfying DB Updatefalse Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: Command Router : Notfying DB Updatefalse Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: Command Router : Notfying DB Updatefalse Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: 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 10 18:34:04 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: No code Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: 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 10 18:34:04 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: No code Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: 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 10 18:34:04 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: No code Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ------------------------------ 243ms Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ------------------------------ 180ms Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ------------------------------ 178ms Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:34:04 volumio-bedroom volumio[961]: info: Feb 10 18:34:04 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: update Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:34:04 volumio-bedroom volumio[961]: info: Feb 10 18:34:04 volumio-bedroom volumio[961]: ---------------------------- MPD announces state update: update Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ControllerMpd::getState Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::sendMpdCommand status Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand status took 23 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand status took 22 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand status took 22 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: info: sendMpdCommand status took 20 milliseconds Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: Command Router : Notfying DB Updatefalse Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: Command Router : Notfying DB Updatefalse Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::Close All Modals sent Feb 10 18:34:04 volumio-bedroom volumio[961]: verbose: ControllerMpd::parseState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: 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 10 18:34:04 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: No code Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ControllerMpd::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::servicePushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: 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 10 18:34:04 volumio-bedroom volumio[961]: verbose: CURRENT POSITION 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState stateService stop Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::syncState currentStatus stop Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: No code Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreStateMachine::pushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CorePlayQueue::getTrack 0 Feb 10 18:34:04 volumio-bedroom volumio[961]: info: CoreCommandRouter::volumioPushState Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ------------------------------ 131ms Feb 10 18:34:04 volumio-bedroom volumio[961]: info: ------------------------------ 130ms Feb 10 18:34:05 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 10 18:34:09 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 10 18:34:11 volumio-bedroom sudo[1042]: pam_unix(sudo:session): session closed for user root Feb 10 18:34:11 volumio-bedroom volumio[961]: info: Cannot mount NAS truenas at system boot, trial number 1 ,retrying in 5 seconds Feb 10 18:34:14 volumio-bedroom volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 10 18:34:16 volumio-bedroom volumio[961]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 18:34:16 volumio-bedroom volumio[961]: TypeError: Cannot read property 'replace' of undefined Feb 10 18:34:16 volumio-bedroom volumio[961]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Feb 10 18:34:16 volumio-bedroom volumio[961]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Feb 10 18:34:16 volumio-bedroom volumio[961]: at listOnTimeout (internal/timers.js:554:17) Feb 10 18:34:16 volumio-bedroom volumio[961]: at processTimers (internal/timers.js:497:7) Feb 10 18:34:16 volumio-bedroom volumio[961]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 18:34:17 volumio-bedroom sudo[1626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-10 18:33 Feb 10 18:34:17 volumio-bedroom sudo[1626]: 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"