-- Logs begin at Thu 2025-05-15 10:29:47 UTC, end at Thu 2025-05-15 14:28:21 UTC. -- May 15 14:27:05 volumio volumio[6872]: verbose: New Socket.io Connection to 192.168.3.108 from 192.168.3.110 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 6 May 15 14:27:05 volumio volumio[6872]: info: CoreCommandRouter::volumioGetState May 15 14:27:05 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:05 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 15 14:27:05 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 15 14:27:06 volumio volumio[6872]: verbose: New Socket.io Connection to 192.168.3.108 from 192.168.3.110 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 7 May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::volumioGetVisibleSources May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::volumioGetState May 15 14:27:06 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 15 14:27:06 volumio volumio[6872]: info: Received Get System Info May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 15 14:27:06 volumio volumio[6872]: info: Discovery: Getting this device information May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::volumioGetState May 15 14:27:06 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::volumioGetState May 15 14:27:06 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:06 volumio volumio[6872]: info: Listing playlists May 15 14:27:06 volumio volumio[6872]: info: CoreCommandRouter::volumioGetQueue May 15 14:27:06 volumio volumio[6872]: info: CoreStateMachine::getQueue May 15 14:27:06 volumio volumio[6872]: info: CorePlayQueue::getQueue May 15 14:27:07 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 15 14:27:08 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 15 14:27:08 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 15 14:27:08 volumio volumio[6872]: info: Discovery: Getting this device information May 15 14:27:08 volumio volumio[6872]: info: CoreCommandRouter::volumioGetState May 15 14:27:08 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:08 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 15 14:27:08 volumio volumio[6872]: verbose: New Socket.io Connection to 192.168.3.77 from 192.168.3.110 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 8 May 15 14:27:08 volumio volumio[6872]: info: CoreCommandRouter::volumioGetState May 15 14:27:08 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:08 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 15 14:27:08 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 15 14:27:08 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand update May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:09 volumio volumio[6872]: info: May 15 14:27:09 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand update took 1 milliseconds May 15 14:27:09 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:09 volumio volumio[6872]: info: May 15 14:27:09 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:09 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:09 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:09 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: 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 15 14:27:09 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: No code May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: ------------------------------ 36ms May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:09 volumio volumio[6872]: info: May 15 14:27:09 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:09 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:09 volumio volumio[6872]: info: May 15 14:27:09 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:09 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand status took 37 milliseconds May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand status took 36 milliseconds May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:09 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:09 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:09 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:09 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: 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 15 14:27:09 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: No code May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: 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 15 14:27:09 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: No code May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: 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 15 14:27:09 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: No code May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: ------------------------------ 117ms May 15 14:27:09 volumio volumio[6872]: info: ------------------------------ 82ms May 15 14:27:09 volumio volumio[6872]: info: ------------------------------ 81ms May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:09 volumio volumio[6872]: info: May 15 14:27:09 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:09 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:09 volumio volumio[6872]: info: May 15 14:27:09 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:09 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand status took 8 milliseconds May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand status took 8 milliseconds May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand status took 7 milliseconds May 15 14:27:09 volumio volumio[6872]: info: sendMpdCommand status took 7 milliseconds May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:09 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:09 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:09 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:09 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: 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 15 14:27:09 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: No code May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: 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 15 14:27:09 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: No code May 15 14:27:09 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:09 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:09 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:09 volumio volumio[6872]: info: ------------------------------ 73ms May 15 14:27:09 volumio volumio[6872]: info: ------------------------------ 73ms May 15 14:27:12 volumio ntpd[944]: Soliciting pool server ::ffff:198.18.0.212 May 15 14:27:12 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand rescan May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:14 volumio volumio[6872]: info: May 15 14:27:14 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand rescan took 1 milliseconds May 15 14:27:14 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:14 volumio volumio[6872]: info: May 15 14:27:14 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:14 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:14 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:14 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: 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 15 14:27:14 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: No code May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: ------------------------------ 34ms May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:14 volumio volumio[6872]: info: May 15 14:27:14 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:14 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:14 volumio volumio[6872]: info: May 15 14:27:14 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:14 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand status took 36 milliseconds May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand status took 37 milliseconds May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand status took 3 milliseconds May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:14 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:14 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:14 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:14 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: 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 15 14:27:14 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: No code May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: 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 15 14:27:14 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: No code May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: 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 15 14:27:14 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: No code May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: ------------------------------ 124ms May 15 14:27:14 volumio volumio[6872]: info: ------------------------------ 90ms May 15 14:27:14 volumio volumio[6872]: info: ------------------------------ 90ms May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:14 volumio volumio[6872]: info: May 15 14:27:14 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:14 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:14 volumio volumio[6872]: info: May 15 14:27:14 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:14 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand status took 10 milliseconds May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand status took 9 milliseconds May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand status took 9 milliseconds May 15 14:27:14 volumio volumio[6872]: info: sendMpdCommand status took 9 milliseconds May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:14 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:14 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:14 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:14 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: 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 15 14:27:14 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: No code May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: 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 15 14:27:14 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: No code May 15 14:27:14 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:14 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:14 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:14 volumio volumio[6872]: info: ------------------------------ 63ms May 15 14:27:14 volumio volumio[6872]: info: ------------------------------ 62ms May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand rescan May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand rescan took 1 milliseconds May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 32ms May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 33 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 33 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 115ms May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 85ms May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 84ms May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 12 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 12 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 11 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 11 milliseconds May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 71ms May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 71ms May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand rescan May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand rescan took 2 milliseconds May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 3 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 3 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 82ms May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 81ms May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 82ms May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 83 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 82 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 182ms May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 101ms May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 101ms May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand rescan May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand rescan took 5 milliseconds May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: May 15 14:27:15 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 7 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 6 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 6 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 5 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 6 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 4 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 3 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 3 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 3 milliseconds May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 176ms May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 175ms May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 174ms May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 173ms May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 172ms May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 172 milliseconds May 15 14:27:15 volumio volumio[6872]: info: sendMpdCommand status took 171 milliseconds May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:27:15 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:27:15 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: 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 15 14:27:15 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: No code May 15 14:27:15 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:27:15 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:27:15 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:27:15 volumio volumio[6872]: info: ------------------------------ 202ms May 15 14:27:16 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:27:20 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:27:24 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:27:28 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:27:29 volumio ntpd[944]: Soliciting pool server ::ffff:198.18.0.213 May 15 14:27:32 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:27:37 volumio volumio[6872]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 14:27:37 volumio volumio[6872]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory May 15 14:27:37 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 15 14:27:37 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork May 15 14:27:37 volumio sudo[7557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 May 15 14:27:37 volumio sudo[7557]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:37 volumio sudo[7557]: pam_unix(sudo:session): session closed for user root May 15 14:27:37 volumio sudo[7563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 15 14:27:37 volumio sudo[7563]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:37 volumio sudo[7572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 15 14:27:37 volumio sudo[7572]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:37 volumio sudo[7563]: pam_unix(sudo:session): session closed for user root May 15 14:27:37 volumio sudo[7582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 15 14:27:37 volumio sudo[7582]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:37 volumio sudo[7572]: pam_unix(sudo:session): session closed for user root May 15 14:27:37 volumio sudo[7593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 15 14:27:37 volumio sudo[7593]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:37 volumio sudo[7593]: pam_unix(sudo:session): session closed for user root May 15 14:27:37 volumio sudo[7582]: pam_unix(sudo:session): session closed for user root May 15 14:27:37 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 15 14:27:37 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 15 14:27:37 volumio sudo[7599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 15 14:27:37 volumio sudo[7599]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:37 volumio sudo[7599]: pam_unix(sudo:session): session closed for user root May 15 14:27:37 volumio sudo[7604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 15 14:27:37 volumio sudo[7604]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:37 volumio sudo[7604]: pam_unix(sudo:session): session closed for user root May 15 14:27:37 volumio volumio[6872]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 15 14:27:37 volumio volumio[6872]: wlan0 Interface doesn't support scanning. May 15 14:27:37 volumio volumio[6872]: info: Cannot use regular scanning, forcing with ap-force May 15 14:27:37 volumio sudo[7609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 15 14:27:37 volumio sudo[7609]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:37 volumio sudo[7609]: pam_unix(sudo:session): session closed for user root May 15 14:27:37 volumio volumio[6872]: command failed: No such device (-19) May 15 14:27:37 volumio volumio[6872]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force May 15 14:27:37 volumio volumio[6872]: command failed: No such device (-19) May 15 14:27:42 volumio ntpd[944]: Soliciting pool server ::ffff:198.18.0.184 May 15 14:27:43 volumio volumio[6872]: info: CALLMETHOD: system_controller network saveWiredNet [object Object] May 15 14:27:43 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: network , saveWiredNet May 15 14:27:43 volumio sudo[7615]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces May 15 14:27:43 volumio sudo[7615]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:43 volumio sudo[7615]: pam_unix(sudo:session): session closed for user root May 15 14:27:43 volumio sudo[7618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf May 15 14:27:43 volumio sudo[7618]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:43 volumio sudo[7618]: pam_unix(sudo:session): session closed for user root May 15 14:27:43 volumio volumio[6872]: info: Permissions for /etc/network/interfaces set May 15 14:27:43 volumio volumio[6872]: info: Restarting Wired Network May 15 14:27:43 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart May 15 14:27:43 volumio volumio[6872]: info: Discovery: Restarting Advertising due to device name change May 15 14:27:43 volumio sudo[7622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ip addr flush dev eth0 May 15 14:27:43 volumio sudo[7622]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:43 volumio avahi-daemon[673]: Withdrawing address record for 192.168.3.77 on eth0. May 15 14:27:43 volumio avahi-daemon[673]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.3.77. May 15 14:27:43 volumio avahi-daemon[673]: Interface eth0.IPv4 no longer relevant for mDNS. May 15 14:27:43 volumio dhcpcd[764]: eth0: pid 7623 deleted IP address 192.168.3.77/24 May 15 14:27:43 volumio dhcpcd[764]: eth0: deleting route to 192.168.3.0/24 May 15 14:27:43 volumio dhcpcd[764]: eth0: deleting default route via 192.168.3.2 May 15 14:27:43 volumio sudo[7622]: pam_unix(sudo:session): session closed for user root May 15 14:27:43 volumio volumio[6872]: info: Discovery: A device disappeared from network May 15 14:27:43 volumio volumio[6872]: info: Discovery: Device volumio disappeared from network May 15 14:27:43 volumio sudo[7625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 down May 15 14:27:43 volumio sudo[7625]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:43 volumio dhcpcd[764]: eth0: probing address 192.168.3.77/24 May 15 14:27:43 volumio dhcpcd[764]: eth0: carrier lost May 15 14:27:43 volumio kernel: r8169 0000:02:00.0 eth0: Link is Down May 15 14:27:43 volumio sudo[7625]: pam_unix(sudo:session): session closed for user root May 15 14:27:43 volumio sudo[7637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 up May 15 14:27:43 volumio sudo[7637]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:43 volumio kernel: RTL8211E Gigabit Ethernet r8169-0-200:00: attached PHY driver (mii_bus:phy_addr=r8169-0-200:00, irq=MAC) May 15 14:27:43 volumio ifplugd(eth0)[958]: Link beat lost. May 15 14:27:43 volumio sudo[7637]: pam_unix(sudo:session): session closed for user root May 15 14:27:43 volumio kernel: r8169 0000:02:00.0 eth0: Link is Down May 15 14:27:45 volumio ntpd[944]: Deleting interface #4 eth0, 192.168.3.77#123, interface stats: received=8, sent=20, dropped=0, active_time=370 secs May 15 14:27:45 volumio ntpd[944]: 198.18.0.213 local addr 192.168.3.77 -> May 15 14:27:45 volumio ntpd[944]: 198.18.0.212 local addr 192.168.3.77 -> May 15 14:27:45 volumio ntpd[944]: 198.18.0.184 local addr 192.168.3.77 -> May 15 14:27:45 volumio ntpd[944]: 198.18.0.206 local addr 192.168.3.77 -> May 15 14:27:46 volumio volumio[6872]: info: Volumio Network Manager: Network status updated: 0 May 15 14:27:46 volumio dhcpcd[764]: eth0: carrier acquired May 15 14:27:46 volumio dhcpcd[764]: eth0: confile file changed, expiring leases May 15 14:27:46 volumio kernel: r8169 0000:02:00.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx May 15 14:27:46 volumio dhcpcd[764]: eth0: IAID 4c:68:74:2b May 15 14:27:46 volumio dhcpcd[764]: eth0: soliciting a DHCP lease May 15 14:27:47 volumio ntpd[944]: error resolving pool 2.debian.pool.ntp.org: System error (-11) May 15 14:27:47 volumio dhcpcd[764]: eth0: soliciting an IPv6 router May 15 14:27:47 volumio ifplugd(eth0)[958]: Link beat detected. May 15 14:27:48 volumio volumio[6872]: info: Discovery: Started advertising with name: Volumio May 15 14:27:51 volumio dhcpcd[764]: eth0: offered 192.168.3.77 from 192.168.3.1 May 15 14:27:51 volumio dhcpcd[764]: eth0: probing address 192.168.3.77/24 May 15 14:27:53 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart May 15 14:27:53 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart May 15 14:27:53 volumio volumio[6872]: info: Refreshing Cached IP Addresses May 15 14:27:53 volumio sudo[7679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli May 15 14:27:53 volumio sudo[7679]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:53 volumio sudo[7679]: pam_unix(sudo:session): session closed for user root May 15 14:27:53 volumio systemd[1]: upmpdcli.service: Succeeded. May 15 14:27:53 volumio sudo[7682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 15 14:27:53 volumio sudo[7682]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:53 volumio sudo[7682]: pam_unix(sudo:session): session closed for user root May 15 14:27:53 volumio sudo[7685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 15 14:27:53 volumio sudo[7685]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:27:53 volumio sudo[7685]: pam_unix(sudo:session): session closed for user root May 15 14:27:57 volumio dhcpcd[764]: eth0: leased 192.168.3.77 for 86400 seconds May 15 14:27:57 volumio dhcpcd[764]: eth0: adding route to 192.168.3.0/24 May 15 14:27:57 volumio dhcpcd[764]: eth0: adding default route via 192.168.3.1 May 15 14:27:57 volumio dhcpcd[764]: eth0: dhcp_envoption 213: Operation not supported May 15 14:27:57 volumio dhcpcd[764]: eth0: dhcp_envoption 213: Operation not supported May 15 14:27:57 volumio avahi-daemon[673]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.3.77. May 15 14:27:57 volumio avahi-daemon[673]: New relevant interface eth0.IPv4 for mDNS. May 15 14:27:57 volumio avahi-daemon[673]: Registering new address record for 192.168.3.77 on eth0.IPv4. May 15 14:27:57 volumio ntpd[944]: ntpd exiting on signal 15 (Terminated) May 15 14:27:57 volumio systemd[1]: Stopping Network Time Service... May 15 14:27:57 volumio systemd[1]: ntp.service: Succeeded. May 15 14:27:57 volumio systemd[1]: Stopped Network Time Service. May 15 14:27:57 volumio systemd[1]: Starting Network Time Service... May 15 14:27:57 volumio ntpd[7738]: ntpd 4.2.8p12@1.3728-o (1): Starting May 15 14:27:57 volumio ntpd[7738]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 May 15 14:27:57 volumio systemd[1]: Started Network Time Service. May 15 14:27:57 volumio ntpd[7745]: proto: precision = 0.081 usec (-23) May 15 14:27:57 volumio ntpd[7745]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 15 14:27:57 volumio ntpd[7745]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 15 14:27:57 volumio ntpd[7745]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 870 days ago May 15 14:27:57 volumio ntpd[7745]: Listen and drop on 0 v6wildcard [::]:123 May 15 14:27:57 volumio ntpd[7745]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 15 14:27:57 volumio ntpd[7745]: Listen normally on 2 lo 127.0.0.1:123 May 15 14:27:57 volumio ntpd[7745]: Listen normally on 3 eth0 192.168.3.77:123 May 15 14:27:57 volumio ntpd[7745]: Listening on routing socket on fd #20 for interface updates May 15 14:27:57 volumio ntpd[7745]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized May 15 14:27:57 volumio ntpd[7745]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized May 15 14:27:59 volumio ntpd[7745]: Soliciting pool server 193.182.111.143 May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 14:27:59 volumio volumio[6872]: info: Retrieving Cloud Streaming UI May 15 14:27:59 volumio volumio[6872]: info: Getting Tidal Cloud Configuration May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 14:27:59 volumio volumio[6872]: info: Getting Qobuz Cloud Configuration May 15 14:27:59 volumio volumio[6872]: info: Asking plugin for UI Config May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 14:27:59 volumio volumio[6872]: info: Getting Spotify Cloud Configuration May 15 14:27:59 volumio volumio[6872]: info: Asking plugin for UI Config May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 14:27:59 volumio volumio[6872]: info: Saving Spotify Acccount May 15 14:27:59 volumio volumio[6872]: info: Got Tidal Cloud Configuration May 15 14:27:59 volumio volumio[6872]: info: Got it May 15 14:27:59 volumio volumio[6872]: info: Got it May 15 14:27:59 volumio volumio[6872]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 14:27:59 volumio volumio[6872]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::volumioGetBrowseSources May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::volumioGetBrowseSources May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::volumioGetBrowseSources May 15 14:27:59 volumio ntpd[7745]: Soliciting pool server 211.68.71.26 May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:27:59 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 15 14:28:00 volumio volumio[6872]: info: Discovery: adding e09d641d-b509-4a13-8b2e-6a793a0a841e May 15 14:28:00 volumio volumio[6872]: info: Discovery: Found device Volumio May 15 14:28:00 volumio volumio[6872]: info: CoreCommandRouter::volumioGetState May 15 14:28:00 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:00 volumio ntpd[7745]: Soliciting pool server 193.182.111.143 May 15 14:28:00 volumio ntpd[7745]: Soliciting pool server 202.118.1.81 May 15 14:28:01 volumio ntpd[7745]: Soliciting pool server 45.76.221.157 May 15 14:28:01 volumio ntpd[7745]: Soliciting pool server 45.76.221.157 May 15 14:28:01 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand rescan May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:01 volumio volumio[6872]: info: May 15 14:28:01 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:28:01 volumio volumio[6872]: info: sendMpdCommand rescan took 1 milliseconds May 15 14:28:01 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:01 volumio volumio[6872]: info: May 15 14:28:01 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:28:01 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:01 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:28:01 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:01 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:28:01 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:01 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:28:01 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:28:01 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:01 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:01 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:01 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:01 volumio volumio[6872]: 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 15 14:28:01 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:28:01 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:28:01 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:28:01 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:01 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:01 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:01 volumio volumio[6872]: info: No code May 15 14:28:01 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:01 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:01 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:01 volumio volumio[6872]: info: ------------------------------ 36ms May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:01 volumio volumio[6872]: info: May 15 14:28:01 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:28:01 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:01 volumio volumio[6872]: info: May 15 14:28:01 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:28:01 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:01 volumio volumio[6872]: info: sendMpdCommand status took 37 milliseconds May 15 14:28:01 volumio volumio[6872]: info: sendMpdCommand status took 36 milliseconds May 15 14:28:01 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:28:01 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:28:01 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:28:01 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:01 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:28:01 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:01 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:02 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:28:02 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:02 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:02 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:28:02 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:02 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: 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 15 14:28:02 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: No code May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: 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 15 14:28:02 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: No code May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: 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 15 14:28:02 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: No code May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: ------------------------------ 118ms May 15 14:28:02 volumio volumio[6872]: info: ------------------------------ 84ms May 15 14:28:02 volumio volumio[6872]: info: ------------------------------ 83ms May 15 14:28:02 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:02 volumio volumio[6872]: info: May 15 14:28:02 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:28:02 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:28:02 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:02 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:02 volumio volumio[6872]: info: May 15 14:28:02 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:28:02 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:28:02 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:02 volumio volumio[6872]: info: sendMpdCommand status took 7 milliseconds May 15 14:28:02 volumio volumio[6872]: info: sendMpdCommand status took 7 milliseconds May 15 14:28:02 volumio volumio[6872]: info: sendMpdCommand status took 8 milliseconds May 15 14:28:02 volumio volumio[6872]: info: sendMpdCommand status took 7 milliseconds May 15 14:28:02 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:02 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:28:02 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:02 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:02 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:28:02 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:02 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: 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 15 14:28:02 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: No code May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: 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 15 14:28:02 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: No code May 15 14:28:02 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:02 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:02 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:02 volumio volumio[6872]: info: ------------------------------ 71ms May 15 14:28:02 volumio volumio[6872]: info: ------------------------------ 72ms May 15 14:28:02 volumio ntpd[7745]: Soliciting pool server 2001:470:1d:281::123 May 15 14:28:03 volumio nmbd[936]: [2025/05/15 14:28:03.126025, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 15 14:28:03 volumio nmbd[936]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.3.77 for name WORKGROUP<1d>. May 15 14:28:03 volumio nmbd[936]: This response was from IP 192.168.3.88, reporting an IP address of 192.168.3.88. May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand update May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:03 volumio volumio[6872]: info: May 15 14:28:03 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:28:03 volumio volumio[6872]: info: sendMpdCommand update took 1 milliseconds May 15 14:28:03 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:03 volumio volumio[6872]: info: May 15 14:28:03 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:28:03 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:03 volumio volumio[6872]: info: sendMpdCommand status took 4 milliseconds May 15 14:28:03 volumio volumio[6872]: info: sendMpdCommand status took 3 milliseconds May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:03 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:03 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: 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 15 14:28:03 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: No code May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: ------------------------------ 37ms May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:03 volumio volumio[6872]: info: May 15 14:28:03 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:28:03 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:03 volumio volumio[6872]: info: May 15 14:28:03 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:28:03 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:03 volumio volumio[6872]: info: sendMpdCommand status took 38 milliseconds May 15 14:28:03 volumio volumio[6872]: info: sendMpdCommand status took 35 milliseconds May 15 14:28:03 volumio volumio[6872]: info: sendMpdCommand status took 2 milliseconds May 15 14:28:03 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:28:03 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:28:03 volumio volumio[6872]: info: sendMpdCommand status took 1 milliseconds May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:03 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:03 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:03 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:03 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: 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 15 14:28:03 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: No code May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: 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 15 14:28:03 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: No code May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: 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 15 14:28:03 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: No code May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: ------------------------------ 128ms May 15 14:28:03 volumio volumio[6872]: info: ------------------------------ 93ms May 15 14:28:03 volumio volumio[6872]: info: ------------------------------ 92ms May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:03 volumio volumio[6872]: info: May 15 14:28:03 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:28:03 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:03 volumio volumio[6872]: info: May 15 14:28:03 volumio volumio[6872]: ---------------------------- MPD announces state update: update May 15 14:28:03 volumio volumio[6872]: info: ControllerMpd::getState May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::sendMpdCommand status May 15 14:28:03 volumio sudo[7826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 15 14:28:03 volumio sudo[7826]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:28:03 volumio volumio[6872]: info: sendMpdCommand status took 25 milliseconds May 15 14:28:03 volumio volumio[6872]: info: sendMpdCommand status took 24 milliseconds May 15 14:28:03 volumio volumio[6872]: info: sendMpdCommand status took 25 milliseconds May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:03 volumio sudo[7826]: pam_unix(sudo:session): session closed for user root May 15 14:28:03 volumio sudo[7828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 15 14:28:03 volumio sudo[7828]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:28:03 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:28:03 volumio sudo[7828]: pam_unix(sudo:session): session closed for user root May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:03 volumio volumio[6872]: info: Command Router : Notfying DB Updatefalse May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::Close All Modals sent May 15 14:28:03 volumio volumio[6872]: verbose: ControllerMpd::parseState May 15 14:28:03 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: 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 15 14:28:03 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: No code May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: ControllerMpd::pushState May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::servicePushState May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: 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 15 14:28:03 volumio volumio[6872]: verbose: CURRENT POSITION 0 May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::syncState stateService stop May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::syncState currentStatus stop May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: No code May 15 14:28:03 volumio volumio[6872]: info: CoreStateMachine::pushState May 15 14:28:03 volumio volumio[6872]: info: CorePlayQueue::getTrack 0 May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::volumioPushState May 15 14:28:03 volumio volumio[6872]: info: ------------------------------ 94ms May 15 14:28:03 volumio volumio[6872]: info: ------------------------------ 94ms May 15 14:28:03 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:28:03 volumio sudo[7838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 15 14:28:03 volumio sudo[7838]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 14:28:03 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 15 14:28:03 volumio sudo[7838]: pam_unix(sudo:session): session closed for user root May 15 14:28:03 volumio volumio[6872]: info: Upmpdcli Daemon Started May 15 14:28:03 volumio volumio[7840]: writing RSA key May 15 14:28:06 volumio volumio[6872]: info: Volumio Network Manager: Network status updated: 1 May 15 14:28:07 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:28:11 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:28:13 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare May 15 14:28:14 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 15 14:28:15 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:28:16 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 15 14:28:16 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 15 14:28:19 volumio volumio[6872]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 15 14:28:21 volumio volumio[6872]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 14:28:21 volumio volumio[6872]: Error: dns service error: unknown May 15 14:28:21 volumio volumio[6872]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) May 15 14:28:21 volumio volumio[6872]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 15 14:28:21 volumio volumio[6872]: errorCode: -65537 May 15 14:28:21 volumio volumio[6872]: } May 15 14:28:21 volumio volumio[6872]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 14:28:21 volumio sudo[7921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-15 14:27 May 15 14:28:21 volumio sudo[7921]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"