-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2025-05-12 17:08:28 CEST. -- May 12 17:07:05 volumio-haupt volumio[943]: info: May 12 17:07:05 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:05 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:05 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:05 volumio-haupt volumio[943]: info: May 12 17:07:05 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:05 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:05 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:05 volumio-haupt volumio[943]: info: May 12 17:07:05 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:05 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:05 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:05 volumio-haupt volumio[943]: info: sendMpdCommand status took 4 milliseconds May 12 17:07:05 volumio-haupt volumio[943]: info: sendMpdCommand status took 2 milliseconds May 12 17:07:05 volumio-haupt volumio[943]: info: sendMpdCommand status took 3 milliseconds May 12 17:07:05 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:05 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:05 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:05 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:05 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:05 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:05 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 2 milliseconds May 12 17:07:05 volumio-haupt volumio[943]: verbose: ControllerMpd::parseTrackInfo May 12 17:07:05 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:05 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 1 May 12 17:07:05 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Forgive Them Father","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/1fa09a76a8daffa91d05c08cfa0e38e4/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F10_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_Forgive_Them_Father.flac","trackType":"flac"} May 12 17:07:05 volumio-haupt volumio[943]: verbose: CURRENT POSITION 1 May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService stop May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus play May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::stPlaybackTimer May 12 17:07:05 volumio-haupt volumio[943]: info: ------------------------------ 21ms May 12 17:07:05 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 12 milliseconds May 12 17:07:05 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 12 milliseconds May 12 17:07:05 volumio-haupt volumio[943]: verbose: ControllerMpd::parseTrackInfo May 12 17:07:05 volumio-haupt volumio[943]: verbose: ControllerMpd::parseTrackInfo May 12 17:07:05 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:05 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:05 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Forgive Them Father","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/1fa09a76a8daffa91d05c08cfa0e38e4/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F10_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_Forgive_Them_Father.flac","trackType":"flac"} May 12 17:07:05 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService stop May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus stop May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:05 volumio-haupt volumio[943]: info: No code May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:05 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:05 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:05 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Forgive Them Father","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/1fa09a76a8daffa91d05c08cfa0e38e4/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F10_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_Forgive_Them_Father.flac","trackType":"flac"} May 12 17:07:05 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService stop May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus stop May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:05 volumio-haupt volumio[943]: info: No code May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:05 volumio-haupt volumio[943]: info: ------------------------------ 35ms May 12 17:07:05 volumio-haupt volumio[943]: info: ------------------------------ 35ms May 12 17:07:05 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:05 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:05 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:05 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:05 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:05 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:05 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:05 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:05 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:06 volumio-haupt volumio[943]: info: Clearing queue after UPNP request May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::ClearQueue May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::clearPlayQueue May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::saveQueue May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushQueue May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:07 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:07 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:07 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:07 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:07 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:07 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:07 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:07 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:07 volumio-haupt volumio[943]: info: sendMpdCommand status took 5 milliseconds May 12 17:07:07 volumio-haupt volumio[943]: info: sendMpdCommand status took 4 milliseconds May 12 17:07:07 volumio-haupt volumio[943]: info: sendMpdCommand status took 3 milliseconds May 12 17:07:07 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:07 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:07 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: 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 12 17:07:07 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: No code May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: 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 12 17:07:07 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: No code May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: 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 12 17:07:07 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: No code May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 33ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 32ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 31ms May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:07 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:07 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:07 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:07 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:07 volumio-haupt volumio[943]: error: updateQueue error: null May 12 17:07:07 volumio-haupt volumio[943]: error: updateQueue error: null May 12 17:07:07 volumio-haupt volumio[943]: error: updateQueue error: null May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 34ms May 12 17:07:07 volumio-haupt volumio[943]: info: sendMpdCommand status took 33 milliseconds May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 4ms May 12 17:07:07 volumio-haupt volumio[943]: info: sendMpdCommand status took 3 milliseconds May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:07 volumio-haupt volumio[943]: info: sendMpdCommand status took 2 milliseconds May 12 17:07:07 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:07 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:07 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:07 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: 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 12 17:07:07 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: No code May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: 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 12 17:07:07 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: No code May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: 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 12 17:07:07 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus stop May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: No code May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 61ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 31ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 31ms May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:07 volumio-haupt volumio[943]: info: Starting UPNP Playback May 12 17:07:07 volumio-haupt volumio[943]: info: Preparing playback through UPNP May 12 17:07:07 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetState May 12 17:07:07 volumio-haupt volumio[943]: info: CorePlayQueue::getTrack 0 May 12 17:07:07 volumio-haupt volumio[943]: info: CoreStateMachine::setConsumeUpdateService mpd May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 1ms May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 4ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: May 12 17:07:07 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:07 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:07 volumio-haupt volumio[943]: info: ------------------------------ 1ms May 12 17:07:08 volumio-haupt volumio[943]: info: May 12 17:07:08 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:08 volumio-haupt volumio[943]: info: May 12 17:07:08 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:08 volumio-haupt volumio[943]: info: May 12 17:07:08 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:08 volumio-haupt volumio[943]: info: May 12 17:07:08 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:08 volumio-haupt volumio[943]: info: May 12 17:07:08 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand status took 5 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand status took 4 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand status took 3 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:08 volumio-haupt volumio[943]: info: May 12 17:07:08 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand status took 6 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand status took 4 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 3 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 3 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 2 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand status took 1 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseTrackInfo May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseTrackInfo May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:08 volumio-haupt volumio[943]: verbose: In UPNP mode May 12 17:07:08 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":340,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Used To Love Him","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/719e1d50ae8b50d919ada2a01af53907/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F09_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_I_Used_To_Love_Him.flac","trackType":"flac"} May 12 17:07:08 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService play May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus stop May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:08 volumio-haupt volumio[943]: verbose: In UPNP mode May 12 17:07:08 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":340,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Used To Love Him","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/719e1d50ae8b50d919ada2a01af53907/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F09_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_I_Used_To_Love_Him.flac","trackType":"flac"} May 12 17:07:08 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService play May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus play May 12 17:07:08 volumio-haupt volumio[943]: info: Received an update from plugin. extracting info from payload May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:08 volumio-haupt volumio[943]: verbose: In UPNP mode May 12 17:07:08 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":340,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Used To Love Him","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/719e1d50ae8b50d919ada2a01af53907/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F09_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_I_Used_To_Love_Him.flac","trackType":"flac"} May 12 17:07:08 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService play May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus play May 12 17:07:08 volumio-haupt volumio[943]: info: Received an update from plugin. extracting info from payload May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: ------------------------------ 23ms May 12 17:07:08 volumio-haupt volumio[943]: info: ------------------------------ 26ms May 12 17:07:08 volumio-haupt volumio[943]: info: ------------------------------ 26ms May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 19 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 19 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 19 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseTrackInfo May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseTrackInfo May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:08 volumio-haupt volumio[943]: verbose: In UPNP mode May 12 17:07:08 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":340,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Used To Love Him","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/719e1d50ae8b50d919ada2a01af53907/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F09_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_I_Used_To_Love_Him.flac","trackType":"flac"} May 12 17:07:08 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService play May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus play May 12 17:07:08 volumio-haupt volumio[943]: info: Received an update from plugin. extracting info from payload May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:08 volumio-haupt volumio[943]: verbose: In UPNP mode May 12 17:07:08 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":340,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Used To Love Him","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/719e1d50ae8b50d919ada2a01af53907/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F09_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_I_Used_To_Love_Him.flac","trackType":"flac"} May 12 17:07:08 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService play May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus play May 12 17:07:08 volumio-haupt volumio[943]: info: Received an update from plugin. extracting info from payload May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:08 volumio-haupt volumio[943]: verbose: In UPNP mode May 12 17:07:08 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":340,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Used To Love Him","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/719e1d50ae8b50d919ada2a01af53907/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F09_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_I_Used_To_Love_Him.flac","trackType":"flac"} May 12 17:07:08 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService play May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus play May 12 17:07:08 volumio-haupt volumio[943]: info: Received an update from plugin. extracting info from payload May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: ------------------------------ 65ms May 12 17:07:08 volumio-haupt volumio[943]: info: ------------------------------ 65ms May 12 17:07:08 volumio-haupt volumio[943]: info: ------------------------------ 63ms May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: info: May 12 17:07:08 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:08 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:08 volumio-haupt volumio[943]: info: May 12 17:07:08 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:08 volumio-haupt volumio[943]: info: May 12 17:07:08 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:08 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:08 volumio-haupt volumio[943]: info: May 12 17:07:08 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:08 volumio-haupt volumio[943]: info: May 12 17:07:08 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:08 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:08 volumio-haupt volumio[943]: info: May 12 17:07:08 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:08 volumio-haupt volumio[943]: info: ------------------------------ 6ms May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand status took 5 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: ------------------------------ 4ms May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand status took 4 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand status took 4 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 2 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 2 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseTrackInfo May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseTrackInfo May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:08 volumio-haupt volumio[943]: verbose: In UPNP mode May 12 17:07:08 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":340,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"I Used To Love Him","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/719e1d50ae8b50d919ada2a01af53907/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F09_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_I_Used_To_Love_Him.flac","trackType":"flac"} May 12 17:07:08 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService play May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus play May 12 17:07:08 volumio-haupt volumio[943]: info: Received an update from plugin. extracting info from payload May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:08 volumio-haupt volumio[943]: verbose: In UPNP mode May 12 17:07:08 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":340,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"I Used To Love Him","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/719e1d50ae8b50d919ada2a01af53907/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F09_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_I_Used_To_Love_Him.flac","trackType":"flac"} May 12 17:07:08 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService play May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus play May 12 17:07:08 volumio-haupt volumio[943]: info: Received an update from plugin. extracting info from payload May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: ------------------------------ 32ms May 12 17:07:08 volumio-haupt volumio[943]: info: ------------------------------ 30ms May 12 17:07:08 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 25 milliseconds May 12 17:07:08 volumio-haupt volumio[943]: verbose: ControllerMpd::parseTrackInfo May 12 17:07:08 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:08 volumio-haupt volumio[943]: verbose: In UPNP mode May 12 17:07:08 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":340,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"I Used To Love Him","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/719e1d50ae8b50d919ada2a01af53907/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F09_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_I_Used_To_Love_Him.flac","trackType":"flac"} May 12 17:07:08 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService play May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus play May 12 17:07:08 volumio-haupt volumio[943]: info: Received an update from plugin. extracting info from payload May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:08 volumio-haupt volumio[943]: info: ------------------------------ 40ms May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:08 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:08 volumio-haupt volumio[943]: info: Starting UPNP Playback May 12 17:07:08 volumio-haupt volumio[943]: info: Preparing playback through UPNP May 12 17:07:08 volumio-haupt volumio[943]: info: Consume mode May 12 17:07:08 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetState May 12 17:07:08 volumio-haupt volumio[943]: info: CoreStateMachine::setConsumeUpdateService mpd May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 1ms May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 4ms May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 1ms May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: May 12 17:07:09 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:09 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 4ms May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:09 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:10 volumio-haupt volumio[943]: info: May 12 17:07:10 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:10 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:10 volumio-haupt volumio[943]: info: May 12 17:07:10 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:10 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:10 volumio-haupt volumio[943]: info: May 12 17:07:10 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:10 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:10 volumio-haupt volumio[943]: info: ------------------------------ 4ms May 12 17:07:10 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:10 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:10 volumio-haupt volumio[943]: info: Starting UPNP Playback May 12 17:07:10 volumio-haupt volumio[943]: info: Preparing playback through UPNP May 12 17:07:10 volumio-haupt volumio[943]: info: Consume mode May 12 17:07:10 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetState May 12 17:07:10 volumio-haupt volumio[943]: info: CoreStateMachine::setConsumeUpdateService mpd May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 4ms May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 7ms May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 6ms May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 5ms May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: May 12 17:07:11 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:11 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:11 volumio-haupt volumio[943]: info: ------------------------------ 1ms May 12 17:07:18 volumio-haupt volumio[943]: info: May 12 17:07:18 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:18 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:18 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:18 volumio-haupt volumio[943]: info: sendMpdCommand status took 2 milliseconds May 12 17:07:18 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:18 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:18 volumio-haupt volumio[943]: info: May 12 17:07:18 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:18 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:18 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:18 volumio-haupt volumio[943]: info: May 12 17:07:18 volumio-haupt volumio[943]: ---------------------------- MPD announces state update: player May 12 17:07:18 volumio-haupt volumio[943]: info: ControllerMpd::getState May 12 17:07:18 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand status May 12 17:07:18 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 6 milliseconds May 12 17:07:18 volumio-haupt volumio[943]: info: sendMpdCommand status took 4 milliseconds May 12 17:07:18 volumio-haupt volumio[943]: info: sendMpdCommand status took 4 milliseconds May 12 17:07:18 volumio-haupt volumio[943]: verbose: ControllerMpd::parseTrackInfo May 12 17:07:18 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:18 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:18 volumio-haupt volumio[943]: verbose: ControllerMpd::parseState May 12 17:07:18 volumio-haupt volumio[943]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 17:07:18 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:18 volumio-haupt volumio[943]: verbose: In UPNP mode May 12 17:07:18 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47000,"duration":340,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"814 Kbps","isStreaming":false,"title":"I Used To Love Him","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/719e1d50ae8b50d919ada2a01af53907/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F09_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_I_Used_To_Love_Him.flac","trackType":"flac"} May 12 17:07:18 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:18 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService play May 12 17:07:18 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus play May 12 17:07:18 volumio-haupt volumio[943]: info: Received an update from plugin. extracting info from payload May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 12 17:07:18 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:18 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:18 volumio-haupt volumio[943]: info: ------------------------------ 33ms May 12 17:07:18 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 20 milliseconds May 12 17:07:18 volumio-haupt volumio[943]: info: sendMpdCommand playlistinfo took 26 milliseconds May 12 17:07:18 volumio-haupt volumio[943]: verbose: ControllerMpd::parseTrackInfo May 12 17:07:18 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:18 volumio-haupt volumio[943]: verbose: In UPNP mode May 12 17:07:18 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47960,"duration":340,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"811 Kbps","isStreaming":false,"title":"I Used To Love Him","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/719e1d50ae8b50d919ada2a01af53907/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F09_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_I_Used_To_Love_Him.flac","trackType":"flac"} May 12 17:07:18 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:18 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService play May 12 17:07:18 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus play May 12 17:07:18 volumio-haupt volumio[943]: info: Received an update from plugin. extracting info from payload May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 12 17:07:18 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:18 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:18 volumio-haupt volumio[943]: info: ControllerMpd::pushState May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::servicePushState May 12 17:07:18 volumio-haupt volumio[943]: verbose: In UPNP mode May 12 17:07:18 volumio-haupt volumio[943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47960,"duration":340,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"914 Kbps","isStreaming":false,"title":"I Used To Love Him","artist":"Lauryn Hill","album":"The Miseducation of Lauryn Hill","uri":"http://192.168.178.52:39237/719e1d50ae8b50d919ada2a01af53907/smb%3A%2F%2F192.168.178.75%2F01_Media%2F03a%20New%20Music%20-%20High%20Res%2FLauryn_Hill%2FThe_Miseducation_of_Lauryn_Hill%2F09_-_Lauryn_Hill_-_The_Miseducation_of_Lauryn_Hill_-_I_Used_To_Love_Him.flac","trackType":"flac"} May 12 17:07:18 volumio-haupt volumio[943]: verbose: CURRENT POSITION 0 May 12 17:07:18 volumio-haupt volumio[943]: info: CoreStateMachine::syncState stateService play May 12 17:07:18 volumio-haupt volumio[943]: info: CoreStateMachine::syncState currentStatus play May 12 17:07:18 volumio-haupt volumio[943]: info: Received an update from plugin. extracting info from payload May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 12 17:07:18 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:18 volumio-haupt volumio[943]: info: CoreStateMachine::pushState May 12 17:07:18 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioPushState May 12 17:07:19 volumio-haupt volumio[943]: info: ------------------------------ 54ms May 12 17:07:19 volumio-haupt volumio[943]: info: ------------------------------ 54ms May 12 17:07:19 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CoreStateMachine::getQueue May 12 17:07:19 volumio-haupt volumio[943]: info: CorePlayQueue::getQueue May 12 17:07:19 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:19 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:19 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:19 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:19 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:19 volumio-haupt volumio[943]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 May 12 17:07:24 volumio-haupt wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network May 12 17:07:29 volumio-haupt wpa_supplicant[841]: RRM: Ignoring radio measurement request: Not RRM network May 12 17:07:44 volumio-haupt volumio[943]: info: May 12 17:07:44 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:44 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:44 volumio-haupt volumio[943]: info: May 12 17:07:44 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:44 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:44 volumio-haupt volumio[943]: info: May 12 17:07:44 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:44 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:44 volumio-haupt volumio[943]: info: ------------------------------ 4ms May 12 17:07:44 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:44 volumio-haupt volumio[943]: info: Starting UPNP Playback May 12 17:07:44 volumio-haupt volumio[943]: info: Preparing playback through UPNP May 12 17:07:44 volumio-haupt volumio[943]: info: Consume mode May 12 17:07:44 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetState May 12 17:07:44 volumio-haupt volumio[943]: info: CoreStateMachine::setConsumeUpdateService mpd May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 1ms May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 7ms May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 6ms May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 5ms May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 1ms May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 1ms May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: May 12 17:07:45 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:45 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:45 volumio-haupt volumio[943]: info: ------------------------------ 1ms May 12 17:07:45 volumio-haupt volumio[943]: info: Starting UPNP Playback May 12 17:07:45 volumio-haupt volumio[943]: info: Preparing playback through UPNP May 12 17:07:45 volumio-haupt volumio[943]: info: Consume mode May 12 17:07:45 volumio-haupt volumio[943]: info: CoreCommandRouter::volumioGetState May 12 17:07:45 volumio-haupt volumio[943]: info: CoreStateMachine::setConsumeUpdateService mpd May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 1ms May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 1ms May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 1ms May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 6ms May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 5ms May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: May 12 17:07:46 volumio-haupt volumio[943]: ---------------------------- MPD announces system playlist update May 12 17:07:46 volumio-haupt volumio[943]: info: Ignoring MPD Status Update May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 3ms May 12 17:07:46 volumio-haupt volumio[943]: info: ------------------------------ 2ms May 12 17:07:59 volumio-haupt volumiologrotate[572]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory May 12 17:07:59 volumio-haupt volumiologrotate[572]: ls: cannot access 'HAUPT': No such file or directory May 12 17:08:27 volumio-haupt volumio[943]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 17:08:27 volumio-haupt volumio[943]: [Error: ENOSPC: no space left on device, write] { May 12 17:08:27 volumio-haupt volumio[943]: errno: -28, May 12 17:08:27 volumio-haupt volumio[943]: code: 'ENOSPC', May 12 17:08:27 volumio-haupt volumio[943]: syscall: 'write' May 12 17:08:27 volumio-haupt volumio[943]: } May 12 17:08:27 volumio-haupt volumio[943]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 17:08:28 volumio-haupt sudo[18443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-12 17:07 May 12 17:08:28 volumio-haupt sudo[18443]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"