-- Logs begin at Tue 2025-11-04 11:43:14 EST, end at Tue 2025-11-04 11:48:48 EST. -- Nov 04 11:47:02 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:06 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:10 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:14 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:18 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:22 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:26 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:30 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:34 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:36 volumio-player sudo[2431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 04 11:47:36 volumio-player sudo[2431]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:47:36 volumio-player sudo[2431]: pam_unix(sudo:session): session closed for user root Nov 04 11:47:36 volumio-player sudo[2434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 04 11:47:36 volumio-player sudo[2434]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:47:36 volumio-player sudo[2434]: pam_unix(sudo:session): session closed for user root Nov 04 11:47:36 volumio-player volumio[1168]: verbose: New Socket.io Connection to 192.168.50.104 from 192.168.50.31 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:144.0) Gecko/20100101 Firefox/144.0 Engine version: 3 Transport: polling Total Clients: 6 Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:47:36 volumio-player volumio[1168]: info: Retrieving Cloud Streaming UI Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetState Nov 04 11:47:36 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 04 11:47:36 volumio-player volumio[1168]: info: Getting Tidal Cloud Configuration Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:47:36 volumio-player volumio[1168]: info: Getting Qobuz Cloud Configuration Nov 04 11:47:36 volumio-player volumio[1168]: info: Asking plugin for UI Config Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:47:36 volumio-player volumio[1168]: info: Getting Spotify Cloud Configuration Nov 04 11:47:36 volumio-player volumio[1168]: info: Asking plugin for UI Config Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:47:36 volumio-player volumio[1168]: info: Saving Spotify Acccount Nov 04 11:47:36 volumio-player volumio[1168]: info: Got Tidal Cloud Configuration Nov 04 11:47:36 volumio-player volumio[1168]: info: Got it Nov 04 11:47:36 volumio-player volumio[1168]: info: Got it Nov 04 11:47:36 volumio-player volumio[1168]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:47:36 volumio-player volumio[1168]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetBrowseSources Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetBrowseSources Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetBrowseSources Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:36 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 04 11:47:38 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 04 11:47:38 volumio-player volumio[1168]: info: Received Get System Info Nov 04 11:47:38 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 11:47:38 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 11:47:38 volumio-player volumio[1168]: info: Discovery: Getting this device information Nov 04 11:47:38 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetState Nov 04 11:47:38 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:38 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 11:47:38 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 04 11:47:38 volumio-player volumio[1168]: info: Received Get System Info Nov 04 11:47:38 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 11:47:38 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 11:47:38 volumio-player volumio[1168]: info: Discovery: Getting this device information Nov 04 11:47:38 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetState Nov 04 11:47:38 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:38 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 11:47:40 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand rescan Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:47:43 volumio-player volumio[1168]: info: Nov 04 11:47:43 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:47:43 volumio-player volumio[1168]: info: sendMpdCommand rescan took 7 milliseconds Nov 04 11:47:43 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:47:43 volumio-player volumio[1168]: info: Nov 04 11:47:43 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:47:43 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:47:43 volumio-player volumio[1168]: info: Nov 04 11:47:43 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:47:43 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:47:43 volumio-player volumio[1168]: info: Nov 04 11:47:43 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:47:43 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:47:43 volumio-player volumio[1168]: info: sendMpdCommand status took 12 milliseconds Nov 04 11:47:43 volumio-player volumio[1168]: info: sendMpdCommand status took 12 milliseconds Nov 04 11:47:43 volumio-player volumio[1168]: info: sendMpdCommand status took 12 milliseconds Nov 04 11:47:43 volumio-player volumio[1168]: info: sendMpdCommand status took 12 milliseconds Nov 04 11:47:43 volumio-player volumio[1168]: info: sendMpdCommand status took 12 milliseconds Nov 04 11:47:43 volumio-player volumio[1168]: info: sendMpdCommand status took 9 milliseconds Nov 04 11:47:43 volumio-player volumio[1168]: info: sendMpdCommand status took 9 milliseconds Nov 04 11:47:43 volumio-player volumio[1168]: info: sendMpdCommand status took 7 milliseconds Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:47:43 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatetrue Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:47:43 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatetrue Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:47:43 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatetrue Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:47:43 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatetrue Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:47:43 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:47:43 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: 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} Nov 04 11:47:43 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:47:43 volumio-player volumio[1168]: info: No code Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:47:43 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: 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} Nov 04 11:47:43 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:47:43 volumio-player volumio[1168]: info: No code Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:47:43 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: 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} Nov 04 11:47:43 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:47:43 volumio-player volumio[1168]: info: No code Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:47:43 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: 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} Nov 04 11:47:43 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:47:43 volumio-player volumio[1168]: info: No code Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:47:43 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:43 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:47:43 volumio-player volumio[1168]: info: ------------------------------ 256ms Nov 04 11:47:43 volumio-player volumio[1168]: info: ------------------------------ 256ms Nov 04 11:47:43 volumio-player volumio[1168]: info: ------------------------------ 255ms Nov 04 11:47:43 volumio-player volumio[1168]: info: ------------------------------ 253ms Nov 04 11:47:44 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Nov 04 11:47:44 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand update Nov 04 11:47:44 volumio-player volumio[1168]: info: sendMpdCommand update took 5 milliseconds Nov 04 11:47:44 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:48 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:52 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:54 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 04 11:47:54 volumio-player volumio[1168]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 04 11:47:54 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 04 11:47:54 volumio-player volumio[1168]: info: Received Get System Version Nov 04 11:47:54 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 04 11:47:54 volumio-player volumio[1168]: info: Received Get System Info Nov 04 11:47:54 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 11:47:54 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 11:47:54 volumio-player volumio[1168]: info: Discovery: Getting this device information Nov 04 11:47:54 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetState Nov 04 11:47:54 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:47:54 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 11:47:56 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:47:57 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Nov 04 11:47:57 volumio-player sudo[2491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/server Nov 04 11:47:57 volumio-player sudo[2491]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:47:57 volumio-player sudo[2491]: pam_unix(sudo:session): session closed for user root Nov 04 11:47:57 volumio-player volumio[1168]: error: Mount point '/mnt/NAS/server' cannot be removed. Error: exec error Error: Command failed: /usr/bin/sudo /bin/umount '/mnt/NAS/server' Nov 04 11:47:57 volumio-player volumio[1168]: umount: /mnt/NAS/server: target is busy. Nov 04 11:47:58 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 04 11:48:00 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:48:00 volumio-player volumio[1168]: info: [1762274880907] Database update started Nov 04 11:48:03 volumio-player volumio[1168]: info: MPD Database updated - AlbumList cache refreshed Nov 04 11:48:03 volumio-player volumio[1168]: info: Nov 04 11:48:03 volumio-player volumio[1168]: ---------------------------- MPD announces state update: database Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:03 volumio-player volumio[1168]: info: Nov 04 11:48:03 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:48:03 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:03 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:03 volumio-player volumio[1168]: info: MPD Database updated - AlbumList cache refreshed Nov 04 11:48:03 volumio-player volumio[1168]: info: Nov 04 11:48:03 volumio-player volumio[1168]: ---------------------------- MPD announces state update: database Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:03 volumio-player volumio[1168]: info: Nov 04 11:48:03 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:48:03 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:03 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:03 volumio-player volumio[1168]: info: MPD Database updated - AlbumList cache refreshed Nov 04 11:48:03 volumio-player volumio[1168]: info: Nov 04 11:48:03 volumio-player volumio[1168]: ---------------------------- MPD announces state update: database Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:03 volumio-player volumio[1168]: info: Nov 04 11:48:03 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:48:03 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:03 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:03 volumio-player volumio[1168]: info: MPD Database updated - AlbumList cache refreshed Nov 04 11:48:03 volumio-player volumio[1168]: info: Nov 04 11:48:03 volumio-player volumio[1168]: ---------------------------- MPD announces state update: database Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:03 volumio-player volumio[1168]: info: Nov 04 11:48:03 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:48:03 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:03 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:03 volumio-player volumio[1168]: info: sendMpdCommand status took 52 milliseconds Nov 04 11:48:03 volumio-player volumio[1168]: info: sendMpdCommand status took 51 milliseconds Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:03 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatetrue Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:03 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:03 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:03 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:03 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:03 volumio-player volumio[1168]: 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} Nov 04 11:48:03 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:03 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:03 volumio-player volumio[1168]: info: No code Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:03 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:03 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:03 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:03 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:03 volumio-player volumio[1168]: 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} Nov 04 11:48:03 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:03 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:03 volumio-player volumio[1168]: info: No code Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:03 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:03 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:03 volumio-player volumio[1168]: info: ------------------------------ 142ms Nov 04 11:48:03 volumio-player volumio[1168]: info: ------------------------------ 143ms Nov 04 11:48:04 volumio-player volumio[1168]: info: sendMpdCommand status took 187 milliseconds Nov 04 11:48:04 volumio-player volumio[1168]: info: sendMpdCommand status took 181 milliseconds Nov 04 11:48:04 volumio-player volumio[1168]: info: sendMpdCommand status took 181 milliseconds Nov 04 11:48:04 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:04 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatetrue Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:04 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:04 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:04 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: 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} Nov 04 11:48:04 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: No code Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: 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} Nov 04 11:48:04 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: No code Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: ------------------------------ 301ms Nov 04 11:48:04 volumio-player volumio[1168]: info: ------------------------------ 300ms Nov 04 11:48:04 volumio-player volumio[1168]: info: sendMpdCommand status took 314 milliseconds Nov 04 11:48:04 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:04 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatetrue Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:04 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:04 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:04 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: 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} Nov 04 11:48:04 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: No code Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: 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} Nov 04 11:48:04 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: No code Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: ------------------------------ 406ms Nov 04 11:48:04 volumio-player volumio[1168]: info: ------------------------------ 406ms Nov 04 11:48:04 volumio-player volumio[1168]: info: sendMpdCommand status took 421 milliseconds Nov 04 11:48:04 volumio-player volumio[1168]: info: sendMpdCommand status took 418 milliseconds Nov 04 11:48:04 volumio-player volumio[1168]: info: sendMpdCommand status took 417 milliseconds Nov 04 11:48:04 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:04 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatetrue Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:04 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:04 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: 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} Nov 04 11:48:04 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: No code Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: 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} Nov 04 11:48:04 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: No code Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:04 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:04 volumio-player volumio[1168]: info: ------------------------------ 517ms Nov 04 11:48:04 volumio-player volumio[1168]: info: ------------------------------ 516ms Nov 04 11:48:04 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:48:08 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:09 volumio-player volumio[1168]: info: Nov 04 11:48:09 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:48:09 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:09 volumio-player volumio[1168]: info: Nov 04 11:48:09 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:48:09 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:09 volumio-player volumio[1168]: info: Nov 04 11:48:09 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:48:09 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:09 volumio-player volumio[1168]: info: Nov 04 11:48:09 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:48:09 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:09 volumio-player volumio[1168]: info: sendMpdCommand status took 7 milliseconds Nov 04 11:48:09 volumio-player volumio[1168]: info: sendMpdCommand status took 6 milliseconds Nov 04 11:48:09 volumio-player volumio[1168]: info: sendMpdCommand status took 5 milliseconds Nov 04 11:48:09 volumio-player volumio[1168]: info: sendMpdCommand status took 3 milliseconds Nov 04 11:48:09 volumio-player volumio[1168]: info: sendMpdCommand status took 2 milliseconds Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:09 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatetrue Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:09 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatetrue Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:09 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatetrue Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:09 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatetrue Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:09 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:09 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: 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} Nov 04 11:48:09 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:09 volumio-player volumio[1168]: info: No code Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:09 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: 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} Nov 04 11:48:09 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:09 volumio-player volumio[1168]: info: No code Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:09 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: 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} Nov 04 11:48:09 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:09 volumio-player volumio[1168]: info: No code Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:09 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: 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} Nov 04 11:48:09 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:09 volumio-player volumio[1168]: info: No code Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:09 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:09 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:09 volumio-player volumio[1168]: info: ------------------------------ 218ms Nov 04 11:48:09 volumio-player volumio[1168]: info: ------------------------------ 218ms Nov 04 11:48:09 volumio-player volumio[1168]: info: ------------------------------ 216ms Nov 04 11:48:12 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Nov 04 11:48:12 volumio-player sudo[2552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/server Nov 04 11:48:12 volumio-player sudo[2552]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:12 volumio-player sudo[2552]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:12 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:48:13 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:15 volumio-player volumio[1168]: info: Nov 04 11:48:15 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:48:15 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:15 volumio-player volumio[1168]: info: Nov 04 11:48:15 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:48:15 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:15 volumio-player volumio[1168]: info: Nov 04 11:48:15 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:48:15 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:15 volumio-player volumio[1168]: info: Nov 04 11:48:15 volumio-player volumio[1168]: ---------------------------- MPD announces state update: update Nov 04 11:48:15 volumio-player volumio[1168]: info: ControllerMpd::getState Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:15 volumio-player volumio[1168]: info: sendMpdCommand status took 5 milliseconds Nov 04 11:48:15 volumio-player volumio[1168]: info: sendMpdCommand status took 5 milliseconds Nov 04 11:48:15 volumio-player volumio[1168]: info: sendMpdCommand status took 4 milliseconds Nov 04 11:48:15 volumio-player volumio[1168]: info: sendMpdCommand status took 4 milliseconds Nov 04 11:48:15 volumio-player volumio[1168]: info: sendMpdCommand status took 3 milliseconds Nov 04 11:48:15 volumio-player volumio[1168]: info: sendMpdCommand status took 3 milliseconds Nov 04 11:48:15 volumio-player volumio[1168]: info: sendMpdCommand status took 2 milliseconds Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:15 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatefalse Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:15 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatefalse Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:15 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatefalse Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:15 volumio-player volumio[1168]: info: Command Router : Notfying DB Updatefalse Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:15 volumio-player volumio[1168]: verbose: ControllerMpd::parseState Nov 04 11:48:15 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: 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} Nov 04 11:48:15 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:15 volumio-player volumio[1168]: info: No code Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:15 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: 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} Nov 04 11:48:15 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:15 volumio-player volumio[1168]: info: No code Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:15 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: 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} Nov 04 11:48:15 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:15 volumio-player volumio[1168]: info: No code Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:15 volumio-player volumio[1168]: info: ControllerMpd::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::servicePushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: 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} Nov 04 11:48:15 volumio-player volumio[1168]: verbose: CURRENT POSITION 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:15 volumio-player volumio[1168]: info: No code Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreStateMachine::pushState Nov 04 11:48:15 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:15 volumio-player volumio[1168]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:15 volumio-player volumio[1168]: info: ------------------------------ 219ms Nov 04 11:48:15 volumio-player volumio[1168]: info: ------------------------------ 219ms Nov 04 11:48:15 volumio-player volumio[1168]: info: ------------------------------ 220ms Nov 04 11:48:15 volumio-player volumio[1168]: info: ------------------------------ 220ms Nov 04 11:48:16 volumio-player sudo[2570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 04 11:48:16 volumio-player sudo[2570]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:16 volumio-player sudo[2570]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:16 volumio-player sudo[2573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 04 11:48:16 volumio-player sudo[2573]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:16 volumio-player sudo[2573]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:16 volumio-player volumio[1168]: verbose: New Socket.io Connection to 192.168.50.104 from 192.168.50.31 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:144.0) Gecko/20100101 Firefox/144.0 Engine version: 3 Transport: polling Total Clients: 6 Nov 04 11:48:16 volumio-player sudo[2578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 04 11:48:16 volumio-player sudo[2578]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:16 volumio-player sudo[2580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 04 11:48:16 volumio-player sudo[2580]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:16 volumio-player sudo[2578]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:16 volumio-player sudo[2580]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:16 volumio-player volumio[1168]: verbose: New Socket.io Connection to 192.168.50.104 from 192.168.50.31 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:144.0) Gecko/20100101 Firefox/144.0 Engine version: 3 Transport: polling Total Clients: 6 Nov 04 11:48:16 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetState Nov 04 11:48:16 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:16 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 04 11:48:16 volumio-player volumio[1168]: info: Listing playlists Nov 04 11:48:16 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 04 11:48:16 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 04 11:48:16 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 04 11:48:16 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 04 11:48:17 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetVisibleSources Nov 04 11:48:17 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 04 11:48:17 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetQueue Nov 04 11:48:17 volumio-player volumio[1168]: info: CoreStateMachine::getQueue Nov 04 11:48:17 volumio-player volumio[1168]: info: CorePlayQueue::getQueue Nov 04 11:48:18 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 04 11:48:18 volumio-player volumio[1168]: info: CURURI: music-library Nov 04 11:48:18 volumio-player volumio[1168]: info: Preload queue cleared Nov 04 11:48:18 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 04 11:48:18 volumio-player volumio[1168]: info: Received Get System Info Nov 04 11:48:18 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 11:48:18 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 11:48:18 volumio-player volumio[1168]: info: Discovery: Getting this device information Nov 04 11:48:18 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetState Nov 04 11:48:18 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:18 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 11:48:19 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 04 11:48:19 volumio-player volumio[1168]: info: Received Get System Info Nov 04 11:48:19 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 04 11:48:19 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 04 11:48:19 volumio-player volumio[1168]: info: Discovery: Getting this device information Nov 04 11:48:19 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetState Nov 04 11:48:19 volumio-player volumio[1168]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:19 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 11:48:19 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 04 11:48:19 volumio-player volumio[1168]: info: CURURI: music-library/NAS Nov 04 11:48:19 volumio-player volumio[1168]: info: Preload queue cleared Nov 04 11:48:20 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 04 11:48:20 volumio-player volumio[1168]: info: CURURI: music-library/NAS/server Nov 04 11:48:20 volumio-player volumio[1168]: info: Preload queue cleared Nov 04 11:48:25 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:48:25 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 04 11:48:25 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 04 11:48:25 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 04 11:48:26 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:48:26 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:48:26 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:48:26 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:48:26 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:48:26 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:48:26 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 04 11:48:26 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:48:28 volumio-player volumio[1168]: info: Retrieving Cloud Streaming UI Nov 04 11:48:28 volumio-player volumio[1168]: info: Getting Tidal Cloud Configuration Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:48:28 volumio-player volumio[1168]: info: Getting Qobuz Cloud Configuration Nov 04 11:48:28 volumio-player volumio[1168]: info: Asking plugin for UI Config Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:48:28 volumio-player volumio[1168]: info: Getting Spotify Cloud Configuration Nov 04 11:48:28 volumio-player volumio[1168]: info: Asking plugin for UI Config Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:48:28 volumio-player volumio[1168]: info: Saving Spotify Acccount Nov 04 11:48:28 volumio-player volumio[1168]: info: Got Tidal Cloud Configuration Nov 04 11:48:28 volumio-player volumio[1168]: info: Got it Nov 04 11:48:28 volumio-player volumio[1168]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 04 11:48:28 volumio-player volumio[1168]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetBrowseSources Nov 04 11:48:28 volumio-player volumio[1168]: info: CoreCommandRouter::volumioGetBrowseSources Nov 04 11:48:29 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:48:29 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 04 11:48:32 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:48:34 volumio-player volumio[1168]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Nov 04 11:48:34 volumio-player sudo[2672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/server Nov 04 11:48:34 volumio-player sudo[2672]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:34 volumio-player sudo[2672]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:34 volumio-player volumio[1168]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 04 11:48:34 volumio-player volumio[1168]: Error: EBUSY: resource busy or locked, rmdir '/mnt/NAS/server' Nov 04 11:48:34 volumio-player volumio[1168]: at Object.rmdirSync (fs.js:917:10) Nov 04 11:48:34 volumio-player volumio[1168]: at /volumio/node_modules/linux-mountutils/mountutils.js:178:12 Nov 04 11:48:34 volumio-player volumio[1168]: at ChildProcess.exithandler (child_process.js:374:7) Nov 04 11:48:34 volumio-player volumio[1168]: at ChildProcess.emit (events.js:400:28) Nov 04 11:48:34 volumio-player volumio[1168]: at maybeClose (internal/child_process.js:1088:16) Nov 04 11:48:34 volumio-player volumio[1168]: at Process.ChildProcess._handle.onexit (internal/child_process.js:296:5) { Nov 04 11:48:34 volumio-player volumio[1168]: errno: -16, Nov 04 11:48:34 volumio-player volumio[1168]: syscall: 'rmdir', Nov 04 11:48:34 volumio-player volumio[1168]: code: 'EBUSY', Nov 04 11:48:34 volumio-player volumio[1168]: path: '/mnt/NAS/server' Nov 04 11:48:34 volumio-player volumio[1168]: } Nov 04 11:48:34 volumio-player volumio[1168]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 04 11:48:34 volumio-player sudo[2684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-04 11:47 Nov 04 11:48:34 volumio-player sudo[2684]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:34 volumio-player sudo[2684]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:35 volumio-player volumio-remote-updater[748]: [2025-11-04 11:48:35] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Nov 04 11:48:35 volumio-player volumio-remote-updater[748]: [2025-11-04 11:48:35] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Nov 04 11:48:35 volumio-player systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 04 11:48:35 volumio-player systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 04 11:48:35 volumio-player systemd[1]: Started dynamicswap service. Nov 04 11:48:35 volumio-player systemd[1]: dynamicswap.service: Succeeded. Nov 04 11:48:35 volumio-player systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 04 11:48:35 volumio-player systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Nov 04 11:48:35 volumio-player systemd[1]: Stopped Volumio Backend Module. Nov 04 11:48:35 volumio-player systemd[1]: Started Volumio Backend Module. Nov 04 11:48:35 volumio-player systemd[1]: Started dynamicswap service. Nov 04 11:48:35 volumio-player systemd[1]: dynamicswap.service: Succeeded. Nov 04 11:48:36 volumio-player volumio[2697]: info: ------------------------------------------- Nov 04 11:48:36 volumio-player volumio[2697]: info: ----- Volumio3 ---- Nov 04 11:48:36 volumio-player volumio[2697]: info: ------------------------------------------- Nov 04 11:48:36 volumio-player volumio[2697]: info: ----- System startup ---- Nov 04 11:48:36 volumio-player volumio[2697]: info: ------------------------------------------- Nov 04 11:48:37 volumio-player volumio[2697]: info: MYVOLUMIO Environment detected Nov 04 11:48:37 volumio-player volumio[2697]: info: Plugin folders cleanup Nov 04 11:48:37 volumio-player volumio[2697]: info: Scanning into folder /volumio/app/plugins/ Nov 04 11:48:37 volumio-player volumio[2697]: info: Scanning category audio_interface Nov 04 11:48:37 volumio-player volumio[2697]: info: Scanning category miscellanea Nov 04 11:48:37 volumio-player volumio[2697]: info: Scanning category music_service Nov 04 11:48:37 volumio-player volumio[2697]: info: Scanning category plugins.json Nov 04 11:48:37 volumio-player volumio[2697]: info: Scanning category system_controller Nov 04 11:48:37 volumio-player volumio[2697]: info: Scanning category user_interface Nov 04 11:48:37 volumio-player volumio[2697]: info: Scanning into folder /data/plugins/ Nov 04 11:48:37 volumio-player volumio[2697]: info: Scanning category audio_interface Nov 04 11:48:37 volumio-player volumio[2697]: info: Plugin folders cleanup completed Nov 04 11:48:37 volumio-player volumio[2697]: info: ------------------------------------------- Nov 04 11:48:37 volumio-player volumio[2697]: info: ----- Core plugins startup ---- Nov 04 11:48:37 volumio-player volumio[2697]: info: ------------------------------------------- Nov 04 11:48:37 volumio-player volumio[2697]: info: Loading plugins from folder /volumio/app/plugins/ Nov 04 11:48:37 volumio-player volumio[2697]: info: Adding plugin upnp to MyMusic Plugins Nov 04 11:48:37 volumio-player volumio[2697]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 04 11:48:37 volumio-player volumio[2697]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 04 11:48:37 volumio-player volumio[2697]: info: Loading plugins from folder /data/plugins/ Nov 04 11:48:37 volumio-player volumio[2697]: info: Loading plugin "system"... Nov 04 11:48:37 volumio-player volumio[2697]: info: Loading plugin "appearance"... Nov 04 11:48:37 volumio-player volumio[2697]: info: Loading plugin "network"... Nov 04 11:48:37 volumio-player volumio[2697]: info: Refreshing Cached IP Addresses Nov 04 11:48:37 volumio-player sudo[2724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 04 11:48:37 volumio-player sudo[2724]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:37 volumio-player sudo[2726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 04 11:48:37 volumio-player sudo[2726]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:37 volumio-player sudo[2724]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:37 volumio-player sudo[2726]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:37 volumio-player volumio[2697]: info: Loading plugin "services"... Nov 04 11:48:37 volumio-player volumio[2697]: info: Loading plugin "alsa_controller"... Nov 04 11:48:37 volumio-player sudo[2737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 04 11:48:37 volumio-player sudo[2737]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:37 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 04 11:48:37 volumio-player volumio[2697]: info: Loading plugin "wizard"... Nov 04 11:48:37 volumio-player volumio[2697]: info: Loading plugin "networkfs"... Nov 04 11:48:37 volumio-player volumio[2697]: info: Cannot mount NAS server at system boot, trial number 1 ,retrying in 5 seconds Nov 04 11:48:37 volumio-player volumio[2697]: info: Cannot mount NAS server at system boot, trial number 1 ,retrying in 5 seconds Nov 04 11:48:37 volumio-player volumio[2697]: info: Starting Udev Watcher for removable devices Nov 04 11:48:37 volumio-player volumio[2697]: info: Ignoring mount for partition: boot Nov 04 11:48:37 volumio-player volumio[2697]: info: Ignoring mount for partition: volumio Nov 04 11:48:37 volumio-player volumio[2697]: info: Ignoring mount for partition: volumio_data Nov 04 11:48:37 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 04 11:48:37 volumio-player volumio[2697]: info: Loading plugin "volumio_command_line_client"... Nov 04 11:48:37 volumio-player volumio[2697]: info: Plugin upnp is not enabled Nov 04 11:48:37 volumio-player volumio[2697]: info: Loading plugin "my_music"... Nov 04 11:48:37 volumio-player volumio[2697]: info: Loading plugin "mpd"... Nov 04 11:48:38 volumio-player volumio[2697]: info: Plugin upnp_browser is not enabled Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading plugin "alarm-clock"... Nov 04 11:48:38 volumio-player volumio[2697]: info: Plugin airplay_emulation is not enabled Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading plugin "last_100"... Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading plugin "webradio"... Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading plugin "i2s_dacs"... Nov 04 11:48:38 volumio-player volumio[2697]: info: I2S DAC not set, start Auto-detection Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading plugin "volumiodiscovery"... Nov 04 11:48:38 volumio-player volumio[2697]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 04 11:48:38 volumio-player volumio[2697]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 04 11:48:38 volumio-player volumio[2697]: *** WARNING *** For more information see Nov 04 11:48:38 volumio-player volumio[2697]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 04 11:48:38 volumio-player volumio[2697]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 04 11:48:38 volumio-player volumio[2697]: *** WARNING *** For more information see Nov 04 11:48:38 volumio-player node[2697]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 04 11:48:38 volumio-player node[2697]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 04 11:48:38 volumio-player node[2697]: *** WARNING *** For more information see Nov 04 11:48:38 volumio-player node[2697]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 04 11:48:38 volumio-player node[2697]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 04 11:48:38 volumio-player node[2697]: *** WARNING *** For more information see Nov 04 11:48:38 volumio-player volumio[2697]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 04 11:48:38 volumio-player volumio[2697]: info: Discovery: Started advertising with name: Volumio-player Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading plugin "outputs"... Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading plugin "albumart"... Nov 04 11:48:38 volumio-player volumio[2697]: info: Plugin example_plugin is not enabled Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading plugin "inputs"... Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading plugin "updater_comm"... Nov 04 11:48:38 volumio-player volumio[2697]: info: Plugin mpdemulation is not enabled Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading plugin "rest_api"... Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading plugin "websocket"... Nov 04 11:48:38 volumio-player volumio[2697]: Forking 1 albumart workers Nov 04 11:48:38 volumio-player volumio[2697]: info: Starting Socket.io Server version 2.3.0 Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading plugin "fusiondsp"... Nov 04 11:48:38 volumio-player volumio[2697]: info: Applying required configuration parameters for plugin fusiondsp Nov 04 11:48:38 volumio-player volumio[2697]: info: Loading i18n strings for locale en Nov 04 11:48:38 volumio-player volumio[2697]: Updating browse sources language Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 04 11:48:38 volumio-player volumio[2697]: Starting albumart workers Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::initPlayerControls Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 04 11:48:38 volumio-player volumio[2697]: Express server listening on port 3000 Nov 04 11:48:38 volumio-player volumio[2697]: [Metrics] WebUI: 2s 543.85ms Nov 04 11:48:38 volumio-player volumio[2697]: info: Setting Device type: x86 Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreStateMachine::resetVolumioState Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreStateMachine::getcurrentVolume Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::volumioRetrievevolume Nov 04 11:48:38 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 04 11:48:38 volumio-player volumio[2697]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Nov 04 11:48:38 volumio-player volumio[2697]: info: Completed loading Core Plugins Nov 04 11:48:38 volumio-player volumio[2697]: info: Preparing to generate the ALSA configuration file Nov 04 11:48:39 volumio-player volumio[2697]: info: Volumio Network Manager: Network status updated: 2 Nov 04 11:48:39 volumio-player volumio[2697]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Nov 04 11:48:39 volumio-player volumio[2697]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 04 11:48:39 volumio-player volumio[2697]: info: Reading ALSA contributions from plugins. Nov 04 11:48:39 volumio-player volumio[2697]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Nov 04 11:48:39 volumio-player volumio[2697]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Nov 04 11:48:39 volumio-player volumio[2697]: info: VolumeController:: Volume=100 Mute =false Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:39 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreStateMachine::updateTrackBlock Nov 04 11:48:39 volumio-player volumio[2697]: info: CorePlayQueue::getTrackBlock Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::volumioRetrievevolume Nov 04 11:48:39 volumio-player volumio[2697]: info: Reloading queue from file Nov 04 11:48:39 volumio-player volumio[2697]: verbose: New Socket.io Connection to 192.168.50.104 from 192.168.50.31 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:144.0) Gecko/20100101 Firefox/144.0 Engine version: 3 Transport: polling Total Clients: 3 Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreStateMachine::setRepeat null single undefined Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:39 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreStateMachine::setRandom false Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:39 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:48:39 volumio-player volumio[2697]: info: VolumeController:: Volume=100 Mute =false Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:39 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:39 volumio-player volumio[2697]: info: Asound.conf file unchanged, so no further update is needed Nov 04 11:48:39 volumio-player volumio[2697]: info: Output device has changed, restarting MPD Nov 04 11:48:39 volumio-player sudo[2787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 04 11:48:39 volumio-player sudo[2787]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:39 volumio-player sudo[2787]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:39 volumio-player volumio[2697]: info: ___________ START PLUGINS ___________ Nov 04 11:48:39 volumio-player volumio[2697]: info: ControllerMpd::onStart: Initializing MPD Nov 04 11:48:39 volumio-player volumio[2697]: info: Creating MPD Configuration file Nov 04 11:48:39 volumio-player sudo[2791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 04 11:48:39 volumio-player sudo[2791]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:39 volumio-player systemd[1]: Stopping Music Player Daemon... Nov 04 11:48:39 volumio-player sudo[2794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 04 11:48:39 volumio-player sudo[2794]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:39 volumio-player sudo[2794]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:39 volumio-player systemd[1]: mpd.service: Succeeded. Nov 04 11:48:39 volumio-player systemd[1]: Stopped Music Player Daemon. Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 04 11:48:39 volumio-player volumio[2697]: info: [1762274919551] CoreMusicLibrary::Adding element Last_100 Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 04 11:48:39 volumio-player volumio[2697]: info: [1762274919555] CoreMusicLibrary::Adding element Webradio Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 04 11:48:39 volumio-player systemd[1]: Starting Music Player Daemon... Nov 04 11:48:39 volumio-player volumio[2697]: info: Initializing BBC Radios Nov 04 11:48:39 volumio-player sudo[2798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 04 11:48:39 volumio-player sudo[2798]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:39 volumio-player volumio[2697]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 04 11:48:39 volumio-player systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 04 11:48:39 volumio-player systemd[1]: mpd.service: Succeeded. Nov 04 11:48:39 volumio-player systemd[1]: Stopped Music Player Daemon. Nov 04 11:48:39 volumio-player systemd[1]: Starting Music Player Daemon... Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 04 11:48:39 volumio-player volumio[2697]: info: Loading i18n strings for locale en Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:39 volumio-player volumio[2697]: info: FusionDsp - mixtype--------------------- Hardware Nov 04 11:48:39 volumio-player volumio[2697]: info: Volumio Calling Home Nov 04 11:48:39 volumio-player sudo[2806]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 04 11:48:39 volumio-player sudo[2806]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:39 volumio-player sudo[2806]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:39 volumio-player volumio[2697]: info: Preparing to generate the ALSA configuration file Nov 04 11:48:39 volumio-player volumio[2697]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 04 11:48:39 volumio-player volumio[2697]: info: Reading ALSA contributions from plugins. Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::volumioGetState Nov 04 11:48:39 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 04 11:48:39 volumio-player volumio[2697]: info: Listing playlists Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::volumioGetVisibleSources Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::volumioGetQueue Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreStateMachine::getQueue Nov 04 11:48:39 volumio-player volumio[2697]: info: CorePlayQueue::getQueue Nov 04 11:48:39 volumio-player volumio[2697]: verbose: New Socket.io Connection to 192.168.50.104 from 192.168.50.31 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:144.0) Gecko/20100101 Firefox/144.0 Engine version: 3 Transport: polling Total Clients: 4 Nov 04 11:48:39 volumio-player volumio[2697]: info: MPD Permissions set Nov 04 11:48:39 volumio-player volumio[2697]: info: MPD Permissions set Nov 04 11:48:39 volumio-player volumio[2697]: info: Discovery: adding 01a57a65-a42c-4f05-ad07-dc7033a167ff Nov 04 11:48:39 volumio-player volumio[2697]: info: Discovery: Found device Volumio-player Nov 04 11:48:39 volumio-player volumio[2697]: info: CoreCommandRouter::volumioGetState Nov 04 11:48:39 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:40 volumio-player mpd[2814]: Nov 04 11:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 04 11:48:40 volumio-player systemd[1]: Started Music Player Daemon. Nov 04 11:48:40 volumio-player sudo[2791]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:40 volumio-player sudo[2798]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:40 volumio-player volumio[2697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 04 11:48:40 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:40 volumio-player volumio-remote-updater[748]: [2025-11-04 11:48:40] [connect] Successful connection Nov 04 11:48:40 volumio-player volumio[2697]: info: Completed starting Core Plugins Nov 04 11:48:40 volumio-player volumio[2697]: info: ------------------------------------------- Nov 04 11:48:40 volumio-player volumio[2697]: info: ----- MyVolumio plugins startup ---- Nov 04 11:48:40 volumio-player volumio[2697]: info: ------------------------------------------- Nov 04 11:48:40 volumio-player volumio[2697]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 04 11:48:40 volumio-player volumio[2697]: info: Volumio called home Nov 04 11:48:41 volumio-player volumio[2697]: info: MPD running with PID2814 Nov 04 11:48:41 volumio-player volumio[2697]: ,establishing connection Nov 04 11:48:41 volumio-player volumio[2697]: error: MPD error: The expression evaluated to a falsy value: Nov 04 11:48:41 volumio-player volumio[2697]: assert.ok(self.idling) Nov 04 11:48:41 volumio-player volumio[2697]: error: The expression evaluated to a falsy value: Nov 04 11:48:41 volumio-player volumio[2697]: assert.ok(self.idling) Nov 04 11:48:41 volumio-player volumio[2697]: error: MPD error: The expression evaluated to a falsy value: Nov 04 11:48:41 volumio-player volumio[2697]: assert.ok(self.idling) Nov 04 11:48:41 volumio-player volumio[2697]: error: The expression evaluated to a falsy value: Nov 04 11:48:41 volumio-player volumio[2697]: assert.ok(self.idling) Nov 04 11:48:41 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:48:41 volumio-player volumio[2697]: error: MPD error: The expression evaluated to a falsy value: Nov 04 11:48:41 volumio-player volumio[2697]: assert.ok(self.idling) Nov 04 11:48:41 volumio-player volumio[2697]: error: The expression evaluated to a falsy value: Nov 04 11:48:41 volumio-player volumio[2697]: assert.ok(self.idling) Nov 04 11:48:41 volumio-player volumio-remote-updater[748]: [2025-11-04 11:48:41] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1762274920 101 Nov 04 11:48:41 volumio-player volumio[2697]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 6 Nov 04 11:48:41 volumio-player volumio[2697]: info: CoreCommandRouter::volumioGetState Nov 04 11:48:41 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:41 volumio-player volumio[2697]: error: updateQueue error: null Nov 04 11:48:41 volumio-player volumio[2697]: info: Asound.conf file unchanged, so no further update is needed Nov 04 11:48:41 volumio-player volumio[2697]: info: Output device has changed, restarting MPD Nov 04 11:48:41 volumio-player sudo[2836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 04 11:48:41 volumio-player sudo[2836]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:41 volumio-player sudo[2836]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:41 volumio-player sudo[2838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 04 11:48:41 volumio-player sudo[2838]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:41 volumio-player volumio[2697]: info: MPD Permissions set Nov 04 11:48:41 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:41 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:41 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:41 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:41 volumio-player systemd[1]: Stopping Music Player Daemon... Nov 04 11:48:41 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 04 11:48:41 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 04 11:48:41 volumio-player systemd[1]: mpd.service: Succeeded. Nov 04 11:48:41 volumio-player systemd[1]: Stopped Music Player Daemon. Nov 04 11:48:41 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:41 volumio-player systemd[1]: Starting Music Player Daemon... Nov 04 11:48:41 volumio-player sudo[2847]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 04 11:48:41 volumio-player sudo[2847]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:41 volumio-player sudo[2847]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:42 volumio-player mpd[2849]: Nov 04 11:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 04 11:48:42 volumio-player systemd[1]: Started Music Player Daemon. Nov 04 11:48:42 volumio-player sudo[2838]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:42 volumio-player volumio[2697]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Nov 04 11:48:42 volumio-player volumio[2697]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Nov 04 11:48:42 volumio-player volumio[2697]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Nov 04 11:48:42 volumio-player volumio[2697]: info: camilladsp service started and running in background, instance 1 Nov 04 11:48:42 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 04 11:48:42 volumio-player volumio[2697]: cannot open device 'volumioHw': Device or resource busy Nov 04 11:48:42 volumio-player volumio[2697]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 04 11:48:42 volumio-player volumio[2697]: cannot open device 'volumioHw': Device or resource busy Nov 04 11:48:42 volumio-player volumio[2697]: info: FusionDsp loaded Nov 04 11:48:42 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 04 11:48:42 volumio-player sudo[2868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 04 11:48:42 volumio-player sudo[2868]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:42 volumio-player volumio[2697]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 04 11:48:42 volumio-player volumio[2697]: info: Adding Signal Path Element [object Object] Nov 04 11:48:42 volumio-player volumio[2697]: info: Adding fusiondspeq DSP Signal Path Element Nov 04 11:48:42 volumio-player volumio[2697]: info: FusionDsp - ---- installed callbackRead Nov 04 11:48:42 volumio-player volumio[2697]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 04 11:48:42 volumio-player sudo[2868]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:42 volumio-player volumio[2697]: info: Cannot mount NAS server at system boot, trial number 2 ,retrying in 5 seconds Nov 04 11:48:42 volumio-player volumio[2697]: info: Cannot mount NAS server at system boot, trial number 2 ,retrying in 5 seconds Nov 04 11:48:42 volumio-player volumio[2697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Nov 04 11:48:42 volumio-player volumio[2697]: info: FusionDsp - {"Reload":{"result":"Ok"}} Nov 04 11:48:42 volumio-player volumio[2697]: error: updateQueue error: null Nov 04 11:48:44 volumio-player sudo[2737]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:44 volumio-player volumio[2697]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Nov 04 11:48:44 volumio-player volumio[2697]: info: CoreCommandRouter::volumioGetState Nov 04 11:48:44 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:44 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 04 11:48:44 volumio-player volumio[2697]: info: Listing playlists Nov 04 11:48:44 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Nov 04 11:48:44 volumio-player sudo[2873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/server Nov 04 11:48:44 volumio-player sudo[2873]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 04 11:48:44 volumio-player systemd[1]: mnt-NAS-server.mount: Succeeded. Nov 04 11:48:44 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 04 11:48:44 volumio-player sudo[2873]: pam_unix(sudo:session): session closed for user root Nov 04 11:48:44 volumio-player volumio[2697]: info: Share server successfully unmounted Nov 04 11:48:45 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 04 11:48:46 volumio-player volumio[2697]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Nov 04 11:48:47 volumio-player volumio[2697]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:47 volumio-player volumio[2697]: info: Nov 04 11:48:47 volumio-player volumio[2697]: ---------------------------- MPD announces state update: update Nov 04 11:48:47 volumio-player volumio[2697]: info: ControllerMpd::getState Nov 04 11:48:47 volumio-player volumio[2697]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:47 volumio-player volumio[2697]: info: [1762274927666] Database update started Nov 04 11:48:47 volumio-player volumio[2697]: info: sendMpdCommand status took 20 milliseconds Nov 04 11:48:47 volumio-player volumio[2697]: info: sendMpdCommand status took 19 milliseconds Nov 04 11:48:47 volumio-player volumio[2697]: verbose: ControllerMpd::parseState Nov 04 11:48:47 volumio-player volumio[2697]: info: Command Router : Notfying DB Updatetrue Nov 04 11:48:47 volumio-player volumio[2697]: verbose: ControllerMpd::parseState Nov 04 11:48:47 volumio-player volumio[2697]: info: ControllerMpd::pushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::servicePushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:47 volumio-player volumio[2697]: 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} Nov 04 11:48:47 volumio-player volumio[2697]: verbose: CURRENT POSITION 0 Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:47 volumio-player volumio[2697]: info: No code Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:47 volumio-player volumio[2697]: info: ------------------------------ 84ms Nov 04 11:48:47 volumio-player volumio[2697]: info: MPD Database updated - AlbumList cache refreshed Nov 04 11:48:47 volumio-player volumio[2697]: info: Nov 04 11:48:47 volumio-player volumio[2697]: ---------------------------- MPD announces state update: database Nov 04 11:48:47 volumio-player volumio[2697]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:47 volumio-player volumio[2697]: info: Nov 04 11:48:47 volumio-player volumio[2697]: ---------------------------- MPD announces state update: update Nov 04 11:48:47 volumio-player volumio[2697]: info: ControllerMpd::getState Nov 04 11:48:47 volumio-player volumio[2697]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:47 volumio-player volumio[2697]: info: ControllerMpd::getState Nov 04 11:48:47 volumio-player volumio[2697]: verbose: ControllerMpd::sendMpdCommand status Nov 04 11:48:47 volumio-player volumio[2697]: info: sendMpdCommand status took 9 milliseconds Nov 04 11:48:47 volumio-player volumio[2697]: info: sendMpdCommand status took 8 milliseconds Nov 04 11:48:47 volumio-player volumio[2697]: info: sendMpdCommand status took 8 milliseconds Nov 04 11:48:47 volumio-player volumio[2697]: verbose: ControllerMpd::parseState Nov 04 11:48:47 volumio-player volumio[2697]: info: Command Router : Notfying DB Updatefalse Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::Close All Modals sent Nov 04 11:48:47 volumio-player volumio[2697]: verbose: ControllerMpd::parseState Nov 04 11:48:47 volumio-player volumio[2697]: verbose: ControllerMpd::parseState Nov 04 11:48:47 volumio-player volumio[2697]: info: ControllerMpd::pushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::servicePushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:47 volumio-player volumio[2697]: 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} Nov 04 11:48:47 volumio-player volumio[2697]: verbose: CURRENT POSITION 0 Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:47 volumio-player volumio[2697]: info: No code Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:47 volumio-player volumio[2697]: info: ControllerMpd::pushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::servicePushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:47 volumio-player volumio[2697]: 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} Nov 04 11:48:47 volumio-player volumio[2697]: verbose: CURRENT POSITION 0 Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::syncState stateService stop Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::syncState currentStatus stop Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:47 volumio-player volumio[2697]: info: No code Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreStateMachine::pushState Nov 04 11:48:47 volumio-player volumio[2697]: info: CorePlayQueue::getTrack 0 Nov 04 11:48:47 volumio-player volumio[2697]: info: CoreCommandRouter::volumioPushState Nov 04 11:48:47 volumio-player volumio[2697]: info: ------------------------------ 173ms Nov 04 11:48:47 volumio-player volumio[2697]: info: ------------------------------ 174ms Nov 04 11:48:47 volumio-player volumio[2697]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 04 11:48:47 volumio-player volumio[2697]: TypeError: Cannot read property 'replace' of undefined Nov 04 11:48:47 volumio-player volumio[2697]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Nov 04 11:48:47 volumio-player volumio[2697]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Nov 04 11:48:47 volumio-player volumio[2697]: at listOnTimeout (internal/timers.js:557:17) Nov 04 11:48:47 volumio-player volumio[2697]: at processTimers (internal/timers.js:500:7) Nov 04 11:48:47 volumio-player volumio[2697]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 04 11:48:48 volumio-player sudo[2910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-04 11:47 Nov 04 11:48:48 volumio-player sudo[2910]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"