-- Logs begin at Tue 2025-05-06 15:29:02 CST, end at Tue 2025-05-06 16:46:54 CST. -- May 06 16:45:10 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:10 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:10 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:10 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:10 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:10 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::getUIConfigOnPlugin May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::getUIConfigOnPlugin May 06 16:45:16 volumio volumio[12761]: info: Retrieving Cloud Streaming UI May 06 16:45:16 volumio volumio[12761]: info: Getting Tidal Cloud Configuration May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::getUIConfigOnPlugin May 06 16:45:16 volumio volumio[12761]: info: Getting Qobuz Cloud Configuration May 06 16:45:16 volumio volumio[12761]: info: Asking plugin for UI Config May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::getUIConfigOnPlugin May 06 16:45:16 volumio volumio[12761]: info: Getting Spotify Cloud Configuration May 06 16:45:16 volumio volumio[12761]: info: Asking plugin for UI Config May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::getUIConfigOnPlugin May 06 16:45:16 volumio volumio[12761]: info: Saving Spotify Acccount May 06 16:45:16 volumio volumio[12761]: info: Got Tidal Cloud Configuration May 06 16:45:16 volumio volumio[12761]: info: Got it May 06 16:45:16 volumio volumio[12761]: info: Got it May 06 16:45:16 volumio volumio[12761]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::getUIConfigOnPlugin May 06 16:45:16 volumio volumio[12761]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::volumioGetBrowseSources May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::volumioGetBrowseSources May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::volumioGetBrowseSources May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 06 16:45:16 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand update May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:20 volumio volumio[12761]: info: May 06 16:45:20 volumio volumio[12761]: ---------------------------- MPD announces state update: update May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand update took 1 milliseconds May 06 16:45:20 volumio volumio[12761]: info: ControllerMpd::getState May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:20 volumio volumio[12761]: info: May 06 16:45:20 volumio volumio[12761]: ---------------------------- MPD announces state update: update May 06 16:45:20 volumio volumio[12761]: info: ControllerMpd::getState May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:20 volumio volumio[12761]: info: May 06 16:45:20 volumio volumio[12761]: ---------------------------- MPD announces state update: update May 06 16:45:20 volumio volumio[12761]: info: ControllerMpd::getState May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:20 volumio volumio[12761]: info: May 06 16:45:20 volumio volumio[12761]: ---------------------------- MPD announces state update: update May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand status took 2 milliseconds May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand status took 1 milliseconds May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand status took 1 milliseconds May 06 16:45:20 volumio volumio[12761]: info: ControllerMpd::getState May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand status took 1 milliseconds May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand status took 2 milliseconds May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand status took 1 milliseconds May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:20 volumio volumio[12761]: info: Command Router : Notfying DB Updatetrue May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:20 volumio volumio[12761]: info: Command Router : Notfying DB Updatetrue May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::Close All Modals sent May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:20 volumio volumio[12761]: info: Command Router : Notfying DB Updatefalse May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::Close All Modals sent May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:20 volumio volumio[12761]: info: ControllerMpd::pushState May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::servicePushState May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: 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} May 06 16:45:20 volumio volumio[12761]: verbose: CURRENT POSITION 0 May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::syncState stateService stop May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::syncState currentStatus stop May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: No code May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: ControllerMpd::pushState May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::servicePushState May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: 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} May 06 16:45:20 volumio volumio[12761]: verbose: CURRENT POSITION 0 May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::syncState stateService stop May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::syncState currentStatus stop May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: No code May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: ControllerMpd::pushState May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::servicePushState May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: 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} May 06 16:45:20 volumio volumio[12761]: verbose: CURRENT POSITION 0 May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::syncState stateService stop May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::syncState currentStatus stop May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: No code May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: ------------------------------ 56ms May 06 16:45:20 volumio volumio[12761]: info: ------------------------------ 55ms May 06 16:45:20 volumio volumio[12761]: info: ------------------------------ 56ms May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:20 volumio volumio[12761]: info: May 06 16:45:20 volumio volumio[12761]: ---------------------------- MPD announces state update: update May 06 16:45:20 volumio volumio[12761]: info: ControllerMpd::getState May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:20 volumio volumio[12761]: info: May 06 16:45:20 volumio volumio[12761]: ---------------------------- MPD announces state update: update May 06 16:45:20 volumio volumio[12761]: info: ControllerMpd::getState May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand status took 56 milliseconds May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand status took 56 milliseconds May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand status took 1 milliseconds May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand status took 1 milliseconds May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand status took 1 milliseconds May 06 16:45:20 volumio volumio[12761]: info: sendMpdCommand status took 0 milliseconds May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:20 volumio volumio[12761]: info: Command Router : Notfying DB Updatefalse May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::Close All Modals sent May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:20 volumio volumio[12761]: info: Command Router : Notfying DB Updatefalse May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::Close All Modals sent May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:20 volumio volumio[12761]: info: Command Router : Notfying DB Updatefalse May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::Close All Modals sent May 06 16:45:20 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:20 volumio volumio[12761]: info: ControllerMpd::pushState May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::servicePushState May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: 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} May 06 16:45:20 volumio volumio[12761]: verbose: CURRENT POSITION 0 May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::syncState stateService stop May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::syncState currentStatus stop May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: No code May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: ControllerMpd::pushState May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::servicePushState May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: 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} May 06 16:45:20 volumio volumio[12761]: verbose: CURRENT POSITION 0 May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::syncState stateService stop May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::syncState currentStatus stop May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: No code May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: ControllerMpd::pushState May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::servicePushState May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: 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} May 06 16:45:20 volumio volumio[12761]: verbose: CURRENT POSITION 0 May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::syncState stateService stop May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::syncState currentStatus stop May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: No code May 06 16:45:20 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:20 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:20 volumio volumio[12761]: info: ------------------------------ 98ms May 06 16:45:20 volumio volumio[12761]: info: ------------------------------ 43ms May 06 16:45:20 volumio volumio[12761]: info: ------------------------------ 44ms May 06 16:45:20 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 06 16:45:24 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand rescan May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:26 volumio volumio[12761]: info: May 06 16:45:26 volumio volumio[12761]: ---------------------------- MPD announces state update: update May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand rescan took 0 milliseconds May 06 16:45:26 volumio volumio[12761]: info: ControllerMpd::getState May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:26 volumio volumio[12761]: info: May 06 16:45:26 volumio volumio[12761]: ---------------------------- MPD announces state update: update May 06 16:45:26 volumio volumio[12761]: info: ControllerMpd::getState May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand status took 1 milliseconds May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand status took 0 milliseconds May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:26 volumio volumio[12761]: info: Command Router : Notfying DB Updatefalse May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::Close All Modals sent May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:26 volumio volumio[12761]: info: ControllerMpd::pushState May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::servicePushState May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: 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} May 06 16:45:26 volumio volumio[12761]: verbose: CURRENT POSITION 0 May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::syncState stateService stop May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::syncState currentStatus stop May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: No code May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: ------------------------------ 19ms May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:26 volumio volumio[12761]: info: May 06 16:45:26 volumio volumio[12761]: ---------------------------- MPD announces state update: update May 06 16:45:26 volumio volumio[12761]: info: ControllerMpd::getState May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:26 volumio volumio[12761]: info: May 06 16:45:26 volumio volumio[12761]: ---------------------------- MPD announces state update: update May 06 16:45:26 volumio volumio[12761]: info: ControllerMpd::getState May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand status took 19 milliseconds May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand status took 19 milliseconds May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand status took 1 milliseconds May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand status took 1 milliseconds May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand status took 0 milliseconds May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand status took 0 milliseconds May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:26 volumio volumio[12761]: info: Command Router : Notfying DB Updatefalse May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::Close All Modals sent May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:26 volumio volumio[12761]: info: Command Router : Notfying DB Updatefalse May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::Close All Modals sent May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:26 volumio volumio[12761]: info: Command Router : Notfying DB Updatefalse May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::Close All Modals sent May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:26 volumio volumio[12761]: info: ControllerMpd::pushState May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::servicePushState May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: 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} May 06 16:45:26 volumio volumio[12761]: verbose: CURRENT POSITION 0 May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::syncState stateService stop May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::syncState currentStatus stop May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: No code May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: ControllerMpd::pushState May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::servicePushState May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: 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} May 06 16:45:26 volumio volumio[12761]: verbose: CURRENT POSITION 0 May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::syncState stateService stop May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::syncState currentStatus stop May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: No code May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: ControllerMpd::pushState May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::servicePushState May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: 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} May 06 16:45:26 volumio volumio[12761]: verbose: CURRENT POSITION 0 May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::syncState stateService stop May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::syncState currentStatus stop May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: No code May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: ------------------------------ 62ms May 06 16:45:26 volumio volumio[12761]: info: ------------------------------ 44ms May 06 16:45:26 volumio volumio[12761]: info: ------------------------------ 43ms May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:26 volumio volumio[12761]: info: May 06 16:45:26 volumio volumio[12761]: ---------------------------- MPD announces state update: update May 06 16:45:26 volumio volumio[12761]: info: ControllerMpd::getState May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:26 volumio volumio[12761]: info: May 06 16:45:26 volumio volumio[12761]: ---------------------------- MPD announces state update: update May 06 16:45:26 volumio volumio[12761]: info: ControllerMpd::getState May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::sendMpdCommand status May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand status took 2 milliseconds May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand status took 2 milliseconds May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand status took 2 milliseconds May 06 16:45:26 volumio volumio[12761]: info: sendMpdCommand status took 2 milliseconds May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:26 volumio volumio[12761]: info: Command Router : Notfying DB Updatefalse May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::Close All Modals sent May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:26 volumio volumio[12761]: info: Command Router : Notfying DB Updatefalse May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::Close All Modals sent May 06 16:45:26 volumio volumio[12761]: verbose: ControllerMpd::parseState May 06 16:45:26 volumio volumio[12761]: info: ControllerMpd::pushState May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::servicePushState May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: 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} May 06 16:45:26 volumio volumio[12761]: verbose: CURRENT POSITION 0 May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::syncState stateService stop May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::syncState currentStatus stop May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: No code May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: ControllerMpd::pushState May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::servicePushState May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: 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} May 06 16:45:26 volumio volumio[12761]: verbose: CURRENT POSITION 0 May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::syncState stateService stop May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::syncState currentStatus stop May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: No code May 06 16:45:26 volumio volumio[12761]: info: CoreStateMachine::pushState May 06 16:45:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:26 volumio volumio[12761]: info: CoreCommandRouter::volumioPushState May 06 16:45:26 volumio volumio[12761]: info: ------------------------------ 32ms May 06 16:45:26 volumio volumio[12761]: info: ------------------------------ 32ms May 06 16:45:28 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 06 16:45:32 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 06 16:45:34 volumio volumio[12761]: info: Enabling MyMusic plugin upnp May 06 16:45:34 volumio volumio[12761]: info: Enabling plugin upnp May 06 16:45:34 volumio volumio[12761]: info: Loading plugin "upnp"... May 06 16:45:34 volumio volumio[12761]: info: [1746521134852] Starting Upmpd Daemon May 06 16:45:34 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 06 16:45:34 volumio volumio[12761]: info: Done. May 06 16:45:36 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 06 16:45:37 volumio volumio[12761]: info: Enabling MyMusic plugin airplay_emulation May 06 16:45:37 volumio volumio[12761]: info: Enabling plugin airplay_emulation May 06 16:45:37 volumio volumio[12761]: info: Loading plugin "airplay_emulation"... May 06 16:45:37 volumio volumio[12761]: info: Starting Shairport Sync May 06 16:45:37 volumio volumio[12761]: info: PLUGIN START: airplay_emulation May 06 16:45:37 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 16:45:37 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 06 16:45:37 volumio volumio[12761]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 06 16:45:37 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 06 16:45:37 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 06 16:45:37 volumio volumio[12761]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 06 16:45:37 volumio volumio[12761]: info: Done. May 06 16:45:37 volumio volumio[12761]: info: Starting Shairport Sync May 06 16:45:37 volumio volumio[12761]: info: Starting Shairport Sync May 06 16:45:37 volumio sudo[13598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 06 16:45:37 volumio sudo[13598]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:45:37 volumio sudo[13601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 06 16:45:37 volumio sudo[13601]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:45:37 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 06 16:45:37 volumio sudo[13598]: pam_unix(sudo:session): session closed for user root May 06 16:45:37 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 06 16:45:37 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM May 06 16:45:37 volumio systemd[1]: shairport-sync.service: Succeeded. May 06 16:45:37 volumio volumio[12761]: info: Shairport-Sync Started May 06 16:45:37 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 06 16:45:37 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 06 16:45:37 volumio volumio[12761]: Error adding Membership: Error: addMembership EINVAL May 06 16:45:37 volumio sudo[13601]: pam_unix(sudo:session): session closed for user root May 06 16:45:37 volumio volumio[12761]: info: Shairport-Sync Started May 06 16:45:38 volumio volumio[12761]: info: Enabling MyMusic plugin upnp_browser May 06 16:45:38 volumio volumio[12761]: info: Enabling plugin upnp_browser May 06 16:45:38 volumio volumio[12761]: info: Loading plugin "upnp_browser"... May 06 16:45:38 volumio volumio[12761]: info: PLUGIN START: upnp_browser May 06 16:45:38 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 06 16:45:38 volumio volumio[12761]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 06 16:45:38 volumio volumio[12761]: info: [1746521138278] CoreMusicLibrary::Adding element Media Servers May 06 16:45:38 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 16:45:38 volumio volumio[12761]: info: Done. May 06 16:45:40 volumio volumio[12761]: info: Enabling MyMusic plugin bluetooth May 06 16:45:40 volumio volumio[12761]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface bluetooth May 06 16:45:40 volumio volumio[12761]: info: [MyVolumio PluginManager] Plugin audio_interface bluetooth not in user plan, not enabling May 06 16:45:40 volumio volumio[12761]: info: Error: Plugin audio_interface bluetooth not in user plan, not enabling May 06 16:45:40 volumio volumio[12761]: error: Could not Enable MyMusic Plugin: Error May 06 16:45:40 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:40 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:40 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:40 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:40 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:40 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:40 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 06 16:45:44 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 06 16:45:44 volumio sudo[13625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 06 16:45:44 volumio sudo[13625]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:45:44 volumio sudo[13625]: pam_unix(sudo:session): session closed for user root May 06 16:45:44 volumio sudo[13628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 06 16:45:44 volumio sudo[13628]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:45:44 volumio sudo[13628]: pam_unix(sudo:session): session closed for user root May 06 16:45:44 volumio sudo[13633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 06 16:45:44 volumio sudo[13633]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:45:44 volumio sudo[13633]: pam_unix(sudo:session): session closed for user root May 06 16:45:44 volumio volumio[12761]: info: Upmpdcli Daemon Started May 06 16:45:46 volumio sudo[13636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 06 16:45:46 volumio sudo[13636]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:45:46 volumio sudo[13636]: pam_unix(sudo:session): session closed for user root May 06 16:45:46 volumio sudo[13639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 06 16:45:46 volumio sudo[13639]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:45:46 volumio sudo[13639]: pam_unix(sudo:session): session closed for user root May 06 16:45:46 volumio volumio[12761]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.10 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_6) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 6 May 06 16:45:46 volumio sudo[13644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 06 16:45:46 volumio sudo[13644]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:45:46 volumio sudo[13644]: pam_unix(sudo:session): session closed for user root May 06 16:45:46 volumio sudo[13647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 06 16:45:46 volumio sudo[13647]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:45:46 volumio sudo[13647]: pam_unix(sudo:session): session closed for user root May 06 16:45:46 volumio volumio[12761]: info: Received Get System Info May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:46 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: Received Get System Info May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:46 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: Received Get System Info May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:46 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetVisibleSources May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 06 16:45:46 volumio volumio[12761]: info: Received Get System Info May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:46 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: Listing playlists May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetQueue May 06 16:45:46 volumio volumio[12761]: info: CoreStateMachine::getQueue May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getQueue May 06 16:45:46 volumio volumio[12761]: info: Received Get System Info May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:46 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: Received Get System Info May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:46 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.10 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_6) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 6 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 06 16:45:46 volumio volumio[12761]: info: Received Get System Info May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:46 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: Received Get System Info May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:46 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: Received Get System Info May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:46 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetVisibleSources May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 06 16:45:46 volumio volumio[12761]: info: Received Get System Info May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:46 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: Listing playlists May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetQueue May 06 16:45:46 volumio volumio[12761]: info: CoreStateMachine::getQueue May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getQueue May 06 16:45:46 volumio volumio[12761]: info: Received Get System Info May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:46 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: Received Get System Info May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:46 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:46 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:46 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:47 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 06 16:45:50 volumio sudo[13652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 06 16:45:50 volumio sudo[13652]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:45:50 volumio sudo[13652]: pam_unix(sudo:session): session closed for user root May 06 16:45:50 volumio sudo[13655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 06 16:45:50 volumio sudo[13655]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:45:50 volumio sudo[13655]: pam_unix(sudo:session): session closed for user root May 06 16:45:50 volumio volumio[12761]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.10 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_6) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 6 May 06 16:45:50 volumio volumio[12761]: info: Received Get System Info May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:50 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: Received Get System Info May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:50 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: Received Get System Info May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:50 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetVisibleSources May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 06 16:45:50 volumio volumio[12761]: info: Received Get System Info May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:50 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: Listing playlists May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetQueue May 06 16:45:50 volumio volumio[12761]: info: CoreStateMachine::getQueue May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getQueue May 06 16:45:50 volumio volumio[12761]: info: Received Get System Info May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:50 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: Received Get System Info May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:50 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: Received Get System Info May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:45:50 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:45:50 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:45:50 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 06 16:45:54 volumio volumio[12761]: info: CoreCommandRouter::getUIConfigOnPlugin May 06 16:45:54 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 06 16:45:54 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 06 16:45:54 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 06 16:45:54 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs May 06 16:45:55 volumio volumio[12761]: info: Received Get System Version May 06 16:45:55 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 06 16:45:56 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 06 16:45:56 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 06 16:46:00 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 06 16:46:10 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:46:10 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:46:10 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:46:10 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:46:10 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:46:10 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:46:11 volumio shairport-sync[13607]: no RTSP header received May 06 16:46:19 volumio volumio[12761]: info: CoreCommandRouter::getUIConfigOnPlugin May 06 16:46:19 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 06 16:46:19 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 06 16:46:19 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 06 16:46:19 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs May 06 16:46:19 volumio volumio[12761]: info: Received Get System Version May 06 16:46:19 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 06 16:46:25 volumio volumio[12761]: info: CALLMETHOD: system_controller system setLanguageTimezone [object Object] May 06 16:46:25 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , setLanguageTimezone May 06 16:46:25 volumio volumio[12761]: info: Setting timezone to Asia/Shanghai May 06 16:46:25 volumio sudo[13784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime May 06 16:46:25 volumio sudo[13784]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:46:25 volumio sudo[13784]: pam_unix(sudo:session): session closed for user root May 06 16:46:25 volumio sudo[13789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime May 06 16:46:25 volumio sudo[13789]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:46:25 volumio sudo[13789]: pam_unix(sudo:session): session closed for user root May 06 16:46:25 volumio sudo[13792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime May 06 16:46:25 volumio sudo[13792]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:46:25 volumio sudo[13792]: pam_unix(sudo:session): session closed for user root May 06 16:46:25 volumio sudo[13795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai May 06 16:46:25 volumio sudo[13795]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:46:25 volumio dbus-daemon[697]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.45' (uid=0 pid=13796 comm="/usr/bin/timedatectl set-timezone Asia/Shanghai ") May 06 16:46:25 volumio systemd[1]: Starting Time & Date Service... May 06 16:46:25 volumio dbus-daemon[697]: [system] Successfully activated service 'org.freedesktop.timedate1' May 06 16:46:25 volumio systemd[1]: Started Time & Date Service. May 06 16:46:25 volumio sudo[13795]: pam_unix(sudo:session): session closed for user root May 06 16:46:25 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage May 06 16:46:25 volumio volumio[12761]: info: Loading i18n strings for locale zh May 06 16:46:25 volumio volumio[12761]: Updating browse sources language May 06 16:46:25 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 16:46:25 volumio sudo[13799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 06 16:46:25 volumio sudo[13799]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:46:25 volumio sudo[13799]: pam_unix(sudo:session): session closed for user root May 06 16:46:25 volumio sudo[13802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 06 16:46:25 volumio sudo[13802]: pam_unix(sudo:session): session opened for user root by (uid=0) May 06 16:46:25 volumio volumio[12761]: info: Fetching Streaming Services browse cache May 06 16:46:25 volumio sudo[13802]: pam_unix(sudo:session): session closed for user root May 06 16:46:25 volumio volumio[12761]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.10 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_6) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 5 May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::volumioGetVisibleSources May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:46:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::getUIConfigOnPlugin May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 06 16:46:26 volumio volumio[12761]: info: Received Get System Info May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:46:26 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:46:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:46:26 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:46:26 volumio volumio[12761]: info: Listing playlists May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs May 06 16:46:26 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 06 16:46:27 volumio volumio[12761]: info: Received Get System Version May 06 16:46:27 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 06 16:46:27 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 06 16:46:27 volumio volumio[12761]: info: Received Get System Info May 06 16:46:27 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:46:27 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:46:27 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:46:27 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:46:27 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:46:27 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:46:28 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 06 16:46:28 volumio volumio[13017]: writing RSA key May 06 16:46:34 volumio volumio[12761]: info: CoreCommandRouter::volumioGetQueue May 06 16:46:34 volumio volumio[12761]: info: CoreStateMachine::getQueue May 06 16:46:34 volumio volumio[12761]: info: CorePlayQueue::getQueue May 06 16:46:35 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 06 16:46:40 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 06 16:46:40 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 06 16:46:40 volumio volumio[12761]: info: Discovery: Getting this device information May 06 16:46:40 volumio volumio[12761]: info: CoreCommandRouter::volumioGetState May 06 16:46:40 volumio volumio[12761]: info: CorePlayQueue::getTrack 0 May 06 16:46:40 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 06 16:46:44 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 16:46:44 volumio volumio[12761]: info: Preload queue cleared May 06 16:46:46 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 16:46:46 volumio volumio[12761]: info: Preload queue cleared May 06 16:46:51 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 16:46:51 volumio volumio[12761]: info: Preload queue cleared May 06 16:46:53 volumio volumio[12761]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 06 16:46:53 volumio volumio[12761]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 16:46:53 volumio volumio[12761]: TypeError: Cannot read property 'length' of undefined May 06 16:46:53 volumio volumio[12761]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 06 16:46:53 volumio volumio[12761]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 06 16:46:53 volumio volumio[12761]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 06 16:46:53 volumio volumio[12761]: at Parser.emit (events.js:400:28) May 06 16:46:53 volumio volumio[12761]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 06 16:46:53 volumio volumio[12761]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 06 16:46:53 volumio volumio[12761]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 06 16:46:53 volumio volumio[12761]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 06 16:46:53 volumio volumio[12761]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 06 16:46:53 volumio volumio[12761]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 06 16:46:53 volumio volumio[12761]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 06 16:46:53 volumio volumio[12761]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 06 16:46:53 volumio volumio[12761]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 06 16:46:53 volumio volumio[12761]: at IncomingMessage.emit (events.js:412:35) May 06 16:46:53 volumio volumio[12761]: at endReadableNT (internal/streams/readable.js:1333:12) May 06 16:46:53 volumio volumio[12761]: at processTicksAndRejections (internal/process/task_queues.js:82:21) May 06 16:46:53 volumio volumio[12761]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 06 16:46:54 volumio sudo[13896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-06 16:45 May 06 16:46:54 volumio sudo[13896]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"