-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2025-12-07 09:28:22 CET. -- Dec 07 09:27:01 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 07 09:27:01 volumio volumio[4282]: info: CURURI: music-library Dec 07 09:27:01 volumio volumio[4282]: error: Failed LSINFO: null Dec 07 09:27:01 volumio volumio[4282]: info: Preload queue cleared Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 09:27:13 volumio volumio[4282]: info: Retrieving Cloud Streaming UI Dec 07 09:27:13 volumio volumio[4282]: info: Getting Tidal Cloud Configuration Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 09:27:13 volumio volumio[4282]: info: Getting Qobuz Cloud Configuration Dec 07 09:27:13 volumio volumio[4282]: info: Asking plugin for UI Config Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 09:27:13 volumio volumio[4282]: info: Getting Spotify Cloud Configuration Dec 07 09:27:13 volumio volumio[4282]: info: Asking plugin for UI Config Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 09:27:13 volumio volumio[4282]: info: Saving Spotify Acccount Dec 07 09:27:13 volumio volumio[4282]: info: Got Tidal Cloud Configuration Dec 07 09:27:13 volumio volumio[4282]: info: Got it Dec 07 09:27:13 volumio volumio[4282]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 09:27:13 volumio volumio[4282]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::volumioGetBrowseSources Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::volumioGetBrowseSources Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::volumioGetBrowseSources Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:27:13 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand update Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:15 volumio volumio[4282]: info: Dec 07 09:27:15 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:15 volumio volumio[4282]: info: sendMpdCommand update took 2 milliseconds Dec 07 09:27:15 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:15 volumio volumio[4282]: info: Dec 07 09:27:15 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:15 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:15 volumio volumio[4282]: info: sendMpdCommand status took 2 milliseconds Dec 07 09:27:15 volumio volumio[4282]: info: sendMpdCommand status took 2 milliseconds Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:15 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:15 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: 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} Dec 07 09:27:15 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:15 volumio volumio[4282]: info: No code Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:15 volumio volumio[4282]: info: ------------------------------ 78ms Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:15 volumio volumio[4282]: info: Dec 07 09:27:15 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:15 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:15 volumio volumio[4282]: info: sendMpdCommand status took 80 milliseconds Dec 07 09:27:15 volumio volumio[4282]: info: sendMpdCommand status took 80 milliseconds Dec 07 09:27:15 volumio volumio[4282]: info: sendMpdCommand status took 2 milliseconds Dec 07 09:27:15 volumio volumio[4282]: info: sendMpdCommand status took 2 milliseconds Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:15 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:15 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:15 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: 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} Dec 07 09:27:15 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:15 volumio volumio[4282]: info: No code Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:15 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: 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} Dec 07 09:27:15 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:15 volumio volumio[4282]: info: No code Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:15 volumio volumio[4282]: info: ------------------------------ 162ms Dec 07 09:27:15 volumio volumio[4282]: info: ------------------------------ 84ms Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:15 volumio volumio[4282]: info: Dec 07 09:27:15 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:15 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:15 volumio volumio[4282]: info: sendMpdCommand status took 8 milliseconds Dec 07 09:27:15 volumio volumio[4282]: info: sendMpdCommand status took 7 milliseconds Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:15 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:15 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:15 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: 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} Dec 07 09:27:15 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:15 volumio volumio[4282]: info: No code Dec 07 09:27:15 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:15 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:15 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:15 volumio volumio[4282]: info: ------------------------------ 48ms Dec 07 09:27:16 volumio ntpd[5948]: 172.232.209.103 local addr 192.168.1.61 -> Dec 07 09:27:16 volumio ntpd[5948]: 31.14.133.122 local addr 192.168.1.61 -> Dec 07 09:27:17 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:27:21 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand update Dec 07 09:27:22 volumio volumio[4282]: info: sendMpdCommand update took 2 milliseconds Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:22 volumio volumio[4282]: info: Dec 07 09:27:22 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:22 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:22 volumio volumio[4282]: info: Dec 07 09:27:22 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:22 volumio volumio[4282]: info: Dec 07 09:27:22 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:22 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:22 volumio volumio[4282]: info: sendMpdCommand status took 2 milliseconds Dec 07 09:27:22 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:22 volumio volumio[4282]: info: sendMpdCommand status took 1 milliseconds Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:22 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:22 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: 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} Dec 07 09:27:22 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:22 volumio volumio[4282]: info: No code Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:22 volumio volumio[4282]: info: ------------------------------ 45ms Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:22 volumio volumio[4282]: info: Dec 07 09:27:22 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:22 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:22 volumio volumio[4282]: info: sendMpdCommand status took 46 milliseconds Dec 07 09:27:22 volumio volumio[4282]: info: sendMpdCommand status took 46 milliseconds Dec 07 09:27:22 volumio volumio[4282]: info: sendMpdCommand status took 45 milliseconds Dec 07 09:27:22 volumio volumio[4282]: info: sendMpdCommand status took 45 milliseconds Dec 07 09:27:22 volumio volumio[4282]: info: sendMpdCommand status took 3 milliseconds Dec 07 09:27:22 volumio volumio[4282]: info: sendMpdCommand status took 2 milliseconds Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:22 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:22 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:22 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:22 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:22 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: 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} Dec 07 09:27:22 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:22 volumio volumio[4282]: info: No code Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:22 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: 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} Dec 07 09:27:22 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:22 volumio volumio[4282]: info: No code Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:22 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: 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} Dec 07 09:27:22 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:22 volumio volumio[4282]: info: No code Dec 07 09:27:22 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:22 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:22 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:22 volumio volumio[4282]: info: ------------------------------ 180ms Dec 07 09:27:22 volumio volumio[4282]: info: ------------------------------ 180ms Dec 07 09:27:22 volumio volumio[4282]: info: ------------------------------ 137ms Dec 07 09:27:25 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:27:29 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:27:33 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:27:35 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Dec 07 09:27:35 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Dec 07 09:27:37 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand rescan Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: info: Dec 07 09:27:40 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand rescan took 1 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: info: Dec 07 09:27:40 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: info: Dec 07 09:27:40 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 2 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 2 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 2 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 1 milliseconds Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: 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} Dec 07 09:27:40 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: No code Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: 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} Dec 07 09:27:40 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: No code Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: ------------------------------ 114ms Dec 07 09:27:40 volumio volumio[4282]: info: ------------------------------ 113ms Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: info: Dec 07 09:27:40 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 114 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 113 milliseconds Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: 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} Dec 07 09:27:40 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: No code Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: ------------------------------ 156ms Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 49 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 48 milliseconds Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: 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} Dec 07 09:27:40 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: No code Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: ------------------------------ 88ms Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand update Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: info: Dec 07 09:27:40 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand update took 2 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: info: Dec 07 09:27:40 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: info: Dec 07 09:27:40 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 3 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 2 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 1 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 1 milliseconds Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: 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} Dec 07 09:27:40 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: No code Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: 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} Dec 07 09:27:40 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: No code Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: ------------------------------ 76ms Dec 07 09:27:40 volumio volumio[4282]: info: ------------------------------ 75ms Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: info: Dec 07 09:27:40 volumio volumio[4282]: ---------------------------- MPD announces state update: update Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::getState Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::sendMpdCommand status Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 78 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 77 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 2 milliseconds Dec 07 09:27:40 volumio volumio[4282]: info: sendMpdCommand status took 1 milliseconds Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: Command Router : Notfying DB Updatefalse Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::Close All Modals sent Dec 07 09:27:40 volumio volumio[4282]: verbose: ControllerMpd::parseState Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: 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} Dec 07 09:27:40 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: No code Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: ControllerMpd::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::servicePushState Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: 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} Dec 07 09:27:40 volumio volumio[4282]: verbose: CURRENT POSITION 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState stateService stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::syncState currentStatus stop Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: No code Dec 07 09:27:40 volumio volumio[4282]: info: CoreStateMachine::pushState Dec 07 09:27:40 volumio volumio[4282]: info: CorePlayQueue::getTrack 1 Dec 07 09:27:40 volumio volumio[4282]: info: CoreCommandRouter::volumioPushState Dec 07 09:27:40 volumio volumio[4282]: info: ------------------------------ 151ms Dec 07 09:27:40 volumio volumio[4282]: info: ------------------------------ 76ms Dec 07 09:27:41 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:27:45 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:27:49 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:27:53 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:27:57 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:28:01 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:28:05 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:28:09 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:28:13 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:28:17 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:28:19 volumio volumio[4282]: info: Disabling MyMusic plugin upnp Dec 07 09:28:19 volumio sudo[8454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Dec 07 09:28:19 volumio sudo[8454]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 09:28:19 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Dec 07 09:28:19 volumio volumio[4282]: error: Upnp client error: Error: This socket has been ended by the other party Dec 07 09:28:21 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 09:28:22 volumio volumio[4282]: info: Enabling MyMusic plugin upnp Dec 07 09:28:22 volumio volumio[4282]: info: Enabling plugin upnp Dec 07 09:28:22 volumio volumio[4282]: info: Loading plugin "upnp"... Dec 07 09:28:22 volumio volumio[4282]: info: [1765096102089] Starting Upmpd Daemon Dec 07 09:28:22 volumio volumio[4282]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 07 09:28:22 volumio volumio[4282]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 09:28:22 volumio volumio[4282]: Error: listen EADDRINUSE: address already in use :::6599 Dec 07 09:28:22 volumio volumio[4282]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Dec 07 09:28:22 volumio volumio[4282]: at listenInCluster (net.js:1366:12) Dec 07 09:28:22 volumio volumio[4282]: at Server.listen (net.js:1452:7) Dec 07 09:28:22 volumio volumio[4282]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Dec 07 09:28:22 volumio volumio[4282]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Dec 07 09:28:22 volumio volumio[4282]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Dec 07 09:28:22 volumio volumio[4282]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Dec 07 09:28:22 volumio volumio[4282]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Dec 07 09:28:22 volumio volumio[4282]: code: 'EADDRINUSE', Dec 07 09:28:22 volumio volumio[4282]: errno: -98, Dec 07 09:28:22 volumio volumio[4282]: syscall: 'listen', Dec 07 09:28:22 volumio volumio[4282]: address: '::', Dec 07 09:28:22 volumio volumio[4282]: port: 6599 Dec 07 09:28:22 volumio volumio[4282]: } Dec 07 09:28:22 volumio volumio[4282]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 09:28:22 volumio sudo[8479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-07 09:27 Dec 07 09:28:22 volumio sudo[8479]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"