-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Mon 2025-01-20 00:12:44 CST. -- Jan 20 00:11:01 volumio volumio[1042]: info: Clearing queue after UPNP request Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::stop Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::serviceStop Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:02 volumio volumio[1042]: info: ControllerMpd::stop Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::saveQueue Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Jan 20 00:11:02 volumio volumio[1042]: info: Jan 20 00:11:02 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:02 volumio volumio[1042]: info: sendMpdCommand stop took 16 milliseconds Jan 20 00:11:02 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:02 volumio volumio[1042]: info: Jan 20 00:11:02 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:02 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:02 volumio volumio[1042]: error: updateQueue error: null Jan 20 00:11:02 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:11:02 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:02 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:02 volumio volumio[1042]: 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} Jan 20 00:11:02 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::syncState stateService stop Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:02 volumio volumio[1042]: info: No code Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:02 volumio volumio[1042]: info: ------------------------------ 21ms Jan 20 00:11:02 volumio volumio[1042]: info: Starting UPNP Playback Jan 20 00:11:02 volumio volumio[1042]: info: Preparing playback through UPNP Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 20 00:11:02 volumio volumio[1042]: info: Jan 20 00:11:02 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:02 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:02 volumio volumio[1042]: info: Jan 20 00:11:02 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:02 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:02 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:02 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:02 volumio volumio[1042]: info: Jan 20 00:11:02 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:02 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:02 volumio volumio[1042]: info: Jan 20 00:11:02 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:02 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:02 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:02 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:02 volumio volumio[1042]: info: Jan 20 00:11:02 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:02 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:02 volumio volumio[1042]: info: Jan 20 00:11:02 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:02 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:02 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:02 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:02 volumio volumio[1042]: info: Jan 20 00:11:02 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:02 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:02 volumio volumio[1042]: info: Jan 20 00:11:02 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:02 volumio volumio[1042]: info: sendMpdCommand status took 19 milliseconds Jan 20 00:11:02 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:02 volumio volumio[1042]: info: sendMpdCommand status took 3 milliseconds Jan 20 00:11:02 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:02 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:02 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:02 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":186,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Eternity","artist":"Anyma (Performer), Anyma (Performer), Anyma (Performer), Anyma (Performer), Anyma (Performer), Anyma (Performer)","album":"Eternity","uri":"http://192.168.100.12:10246/MDEServer/9AE7ECD6-5A6D-4C4C-A28D-22FDC7764BBA/1000.flac","trackType":"flac"} Jan 20 00:11:02 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:11:02 volumio volumio[1042]: info: ------------------------------ 27ms Jan 20 00:11:02 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:02 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:02 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:02 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":186,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Eternity","artist":"Anyma (Performer), Anyma (Performer), Anyma (Performer), Anyma (Performer), Anyma (Performer), Anyma (Performer)","album":"Eternity","uri":"http://192.168.100.12:10246/MDEServer/9AE7ECD6-5A6D-4C4C-A28D-22FDC7764BBA/1000.flac","trackType":"flac"} Jan 20 00:11:02 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:11:02 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:02 volumio volumio[1042]: info: ------------------------------ 27ms Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:02 volumio volumio[1042]: info: Jan 20 00:11:02 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:02 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:02 volumio volumio[1042]: info: Jan 20 00:11:02 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:02 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:02 volumio volumio[1042]: info: ------------------------------ 8ms Jan 20 00:11:02 volumio volumio[1042]: info: sendMpdCommand status took 8 milliseconds Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:02 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 00:11:02 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:02 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:02 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:02 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":81,"duration":186,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2357 Kbps","isStreaming":false,"title":"Eternity","artist":"Anyma","album":"Eternity","uri":"http://192.168.100.12:10246/MDEServer/9AE7ECD6-5A6D-4C4C-A28D-22FDC7764BBA/1000.flac","trackType":"flac"} Jan 20 00:11:02 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:11:02 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:02 volumio volumio[1042]: info: ------------------------------ 31ms Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:02 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:02 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:02 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:14 volumio volumio[1042]: info: Clearing queue after UPNP request Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::stop Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Jan 20 00:11:15 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:15 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::serviceStop Jan 20 00:11:15 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:15 volumio volumio[1042]: info: ControllerMpd::stop Jan 20 00:11:15 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 00:11:15 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Jan 20 00:11:15 volumio volumio[1042]: info: CorePlayQueue::saveQueue Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Jan 20 00:11:15 volumio volumio[1042]: info: sendMpdCommand stop took 21 milliseconds Jan 20 00:11:15 volumio volumio[1042]: info: Jan 20 00:11:15 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:15 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:15 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:15 volumio volumio[1042]: info: Jan 20 00:11:15 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:15 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:15 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:11:15 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:15 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:15 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:15 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:15 volumio volumio[1042]: 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} Jan 20 00:11:15 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::syncState stateService stop Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:15 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:15 volumio volumio[1042]: info: No code Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:15 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:15 volumio volumio[1042]: info: ------------------------------ 14ms Jan 20 00:11:15 volumio volumio[1042]: error: updateQueue error: null Jan 20 00:11:15 volumio volumio[1042]: info: ------------------------------ 18ms Jan 20 00:11:15 volumio volumio[1042]: info: Starting UPNP Playback Jan 20 00:11:15 volumio volumio[1042]: info: Preparing playback through UPNP Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Jan 20 00:11:15 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 20 00:11:15 volumio volumio[1042]: info: Jan 20 00:11:15 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:15 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:15 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:15 volumio volumio[1042]: info: Jan 20 00:11:15 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:15 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:15 volumio volumio[1042]: info: ------------------------------ 0ms Jan 20 00:11:15 volumio volumio[1042]: info: Jan 20 00:11:15 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:15 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:15 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:15 volumio volumio[1042]: info: Jan 20 00:11:15 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:15 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:15 volumio volumio[1042]: info: Jan 20 00:11:15 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:15 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:15 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:15 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:15 volumio volumio[1042]: info: Jan 20 00:11:15 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:15 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:15 volumio volumio[1042]: info: ------------------------------ 0ms Jan 20 00:11:15 volumio volumio[1042]: info: Jan 20 00:11:15 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:15 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:15 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:15 volumio volumio[1042]: info: Jan 20 00:11:15 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:15 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:15 volumio volumio[1042]: info: Jan 20 00:11:15 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:15 volumio volumio[1042]: info: sendMpdCommand status took 45 milliseconds Jan 20 00:11:15 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:15 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:15 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:15 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:15 volumio volumio[1042]: info: ------------------------------ 5ms Jan 20 00:11:15 volumio volumio[1042]: info: sendMpdCommand status took 4 milliseconds Jan 20 00:11:15 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 20 00:11:15 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:15 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:15 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:15 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:15 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:15 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":429,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Shapes in the Spray","artist":"Klangphonics","album":"Shapes in the Spray","uri":"http://192.168.100.12:10246/MDEServer/6701D83D-9A62-47AB-8DFC-63D65943DEFB/1000.flac","trackType":"flac"} Jan 20 00:11:15 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:11:15 volumio volumio[1042]: info: ------------------------------ 52ms Jan 20 00:11:15 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 00:11:15 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:15 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:15 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:15 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":346,"duration":429,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4190 Kbps","isStreaming":false,"title":"Shapes in the Spray","artist":"Klangphonics","album":"Shapes in the Spray","uri":"http://192.168.100.12:10246/MDEServer/6701D83D-9A62-47AB-8DFC-63D65943DEFB/1000.flac","trackType":"flac"} Jan 20 00:11:15 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:11:15 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:15 volumio volumio[1042]: info: ------------------------------ 24ms Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:15 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:15 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:15 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:15 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:17 volumio volumio[1042]: info: Clearing queue after UPNP request Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::stop Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Jan 20 00:11:17 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:17 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:17 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:17 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::serviceStop Jan 20 00:11:17 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:17 volumio volumio[1042]: info: ControllerMpd::stop Jan 20 00:11:17 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 00:11:17 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Jan 20 00:11:17 volumio volumio[1042]: info: CorePlayQueue::saveQueue Jan 20 00:11:17 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:17 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Jan 20 00:11:17 volumio volumio[1042]: info: Jan 20 00:11:17 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:17 volumio volumio[1042]: info: sendMpdCommand stop took 14 milliseconds Jan 20 00:11:17 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:17 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:17 volumio volumio[1042]: info: Jan 20 00:11:17 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:17 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:17 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:11:17 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:17 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:17 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:17 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:17 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:17 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:17 volumio volumio[1042]: 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} Jan 20 00:11:17 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::syncState stateService stop Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:17 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:17 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:17 volumio volumio[1042]: info: No code Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:17 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:17 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:17 volumio volumio[1042]: info: ------------------------------ 18ms Jan 20 00:11:17 volumio volumio[1042]: error: updateQueue error: null Jan 20 00:11:17 volumio volumio[1042]: info: ------------------------------ 17ms Jan 20 00:11:17 volumio volumio[1042]: info: Starting UPNP Playback Jan 20 00:11:17 volumio volumio[1042]: info: Preparing playback through UPNP Jan 20 00:11:17 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Jan 20 00:11:17 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:17 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 20 00:11:17 volumio volumio[1042]: info: Jan 20 00:11:17 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:17 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:17 volumio volumio[1042]: info: Jan 20 00:11:17 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:17 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:17 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:11:17 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:17 volumio volumio[1042]: info: Jan 20 00:11:17 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:17 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:17 volumio volumio[1042]: info: Jan 20 00:11:17 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:17 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:17 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:11:17 volumio volumio[1042]: info: ------------------------------ 0ms Jan 20 00:11:17 volumio volumio[1042]: info: Jan 20 00:11:17 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:17 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:17 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:17 volumio volumio[1042]: info: Jan 20 00:11:17 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:17 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:17 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:18 volumio volumio[1042]: info: Jan 20 00:11:18 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:18 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:18 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:18 volumio volumio[1042]: info: sendMpdCommand status took 17 milliseconds Jan 20 00:11:18 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:18 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:18 volumio volumio[1042]: info: Jan 20 00:11:18 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:18 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:18 volumio volumio[1042]: info: Jan 20 00:11:18 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:18 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:18 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:18 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 20 00:11:18 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:18 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:18 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:18 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:18 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":201,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":6,"random":false,"updatedb":false,"repeat":false,"bitrate":"935 Kbps","isStreaming":false,"title":"React","artist":"Switch Disco","album":"React","uri":"http://192.168.100.12:10246/MDEServer/B1F062DC-9454-4743-AD27-C89AFB6AF1EF/1000.flac","trackType":"flac"} Jan 20 00:11:18 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:18 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:18 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:11:18 volumio volumio[1042]: info: ------------------------------ 23ms Jan 20 00:11:18 volumio volumio[1042]: info: ------------------------------ 5ms Jan 20 00:11:18 volumio volumio[1042]: info: sendMpdCommand status took 3 milliseconds Jan 20 00:11:18 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:18 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:18 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 00:11:18 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:18 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:18 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:18 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:18 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":761,"duration":201,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":6,"random":false,"updatedb":false,"repeat":false,"bitrate":"1131 Kbps","isStreaming":false,"title":"React","artist":"Switch Disco","album":"React","uri":"http://192.168.100.12:10246/MDEServer/B1F062DC-9454-4743-AD27-C89AFB6AF1EF/1000.flac","trackType":"flac"} Jan 20 00:11:18 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:18 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:18 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:11:18 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:11:18 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:11:18 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:18 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:18 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:18 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:18 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:18 volumio volumio[1042]: info: ------------------------------ 16ms Jan 20 00:11:18 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:18 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:18 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:18 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:18 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:18 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:29 volumio volumio[1042]: info: Clearing queue after UPNP request Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::stop Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Jan 20 00:11:29 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:29 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:29 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:29 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::serviceStop Jan 20 00:11:29 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:29 volumio volumio[1042]: info: ControllerMpd::stop Jan 20 00:11:29 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 00:11:29 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Jan 20 00:11:29 volumio volumio[1042]: info: CorePlayQueue::saveQueue Jan 20 00:11:29 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:29 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Jan 20 00:11:29 volumio volumio[1042]: info: Jan 20 00:11:29 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:29 volumio volumio[1042]: info: sendMpdCommand stop took 15 milliseconds Jan 20 00:11:29 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:29 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:29 volumio volumio[1042]: info: Jan 20 00:11:29 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:29 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:29 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:11:29 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:29 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:29 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:29 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:29 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:29 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:29 volumio volumio[1042]: 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} Jan 20 00:11:29 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::syncState stateService stop Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:29 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:29 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:29 volumio volumio[1042]: info: No code Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:29 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:29 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:29 volumio volumio[1042]: info: ------------------------------ 14ms Jan 20 00:11:29 volumio volumio[1042]: error: updateQueue error: null Jan 20 00:11:29 volumio volumio[1042]: info: ------------------------------ 14ms Jan 20 00:11:29 volumio volumio[1042]: info: Starting UPNP Playback Jan 20 00:11:29 volumio volumio[1042]: info: Preparing playback through UPNP Jan 20 00:11:29 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Jan 20 00:11:29 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:29 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 20 00:11:30 volumio volumio[1042]: info: Jan 20 00:11:30 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:30 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:30 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:30 volumio volumio[1042]: info: Jan 20 00:11:30 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:30 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:30 volumio volumio[1042]: info: Jan 20 00:11:30 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:30 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:30 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:11:30 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:30 volumio volumio[1042]: info: Jan 20 00:11:30 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:30 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:30 volumio volumio[1042]: info: Jan 20 00:11:30 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:30 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:30 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:30 volumio volumio[1042]: info: ------------------------------ 0ms Jan 20 00:11:30 volumio volumio[1042]: info: Jan 20 00:11:30 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:30 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:30 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:30 volumio volumio[1042]: info: Jan 20 00:11:30 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:30 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:30 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:30 volumio volumio[1042]: info: Jan 20 00:11:30 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:30 volumio volumio[1042]: info: sendMpdCommand status took 18 milliseconds Jan 20 00:11:30 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:30 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:30 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:30 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:30 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:11:30 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 20 00:11:30 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:30 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:30 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:30 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:30 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:30 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":186,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Eternity","artist":"Anyma (Performer), Anyma (Performer), Anyma (Performer), Anyma (Performer), Anyma (Performer), Anyma (Performer)","album":"Eternity","uri":"http://192.168.100.12:10246/MDEServer/3889E6EE-D464-404B-BBC9-9845D8C9941C/1000.flac","trackType":"flac"} Jan 20 00:11:30 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:11:30 volumio volumio[1042]: info: ------------------------------ 22ms Jan 20 00:11:30 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 20 00:11:30 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:30 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:30 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:30 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":186,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Eternity","artist":"Anyma (Performer), Anyma (Performer), Anyma (Performer), Anyma (Performer), Anyma (Performer), Anyma (Performer)","album":"Eternity","uri":"http://192.168.100.12:10246/MDEServer/3889E6EE-D464-404B-BBC9-9845D8C9941C/1000.flac","trackType":"flac"} Jan 20 00:11:30 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:11:30 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:30 volumio volumio[1042]: info: ------------------------------ 19ms Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:30 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:30 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:30 volumio volumio[1042]: info: Jan 20 00:11:30 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:30 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:30 volumio volumio[1042]: info: Jan 20 00:11:30 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:30 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:30 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:30 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:11:30 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:11:30 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:30 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:30 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 20 00:11:30 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:30 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:30 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:30 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":139,"duration":186,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2357 Kbps","isStreaming":false,"title":"Eternity","artist":"Anyma","album":"Eternity","uri":"http://192.168.100.12:10246/MDEServer/3889E6EE-D464-404B-BBC9-9845D8C9941C/1000.flac","trackType":"flac"} Jan 20 00:11:30 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:11:30 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:30 volumio volumio[1042]: info: ------------------------------ 17ms Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:30 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:30 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:30 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:30 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:30 volumio volumio[1042]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Anyma/Eternity/9e0fd6bb-f453-441a-8794-b44bc5f97bbf.jpg' Jan 20 00:11:31 volumio volumio[1042]: info: Clearing queue after UPNP request Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::stop Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Jan 20 00:11:31 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:31 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:31 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:31 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::serviceStop Jan 20 00:11:31 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:31 volumio volumio[1042]: info: ControllerMpd::stop Jan 20 00:11:31 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 00:11:31 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Jan 20 00:11:31 volumio volumio[1042]: info: CorePlayQueue::saveQueue Jan 20 00:11:31 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:31 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Jan 20 00:11:31 volumio volumio[1042]: info: Jan 20 00:11:31 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:31 volumio volumio[1042]: info: sendMpdCommand stop took 17 milliseconds Jan 20 00:11:31 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:31 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:31 volumio volumio[1042]: info: Jan 20 00:11:31 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:31 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:31 volumio volumio[1042]: error: updateQueue error: null Jan 20 00:11:31 volumio volumio[1042]: info: sendMpdCommand status took 2 milliseconds Jan 20 00:11:31 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:31 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:31 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:31 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:31 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:31 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:31 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:31 volumio volumio[1042]: 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} Jan 20 00:11:31 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::syncState stateService stop Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:31 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:31 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:31 volumio volumio[1042]: info: No code Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:31 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:31 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:31 volumio volumio[1042]: info: ------------------------------ 14ms Jan 20 00:11:31 volumio volumio[1042]: info: Starting UPNP Playback Jan 20 00:11:31 volumio volumio[1042]: info: Preparing playback through UPNP Jan 20 00:11:31 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Jan 20 00:11:31 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:31 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 20 00:11:32 volumio volumio[1042]: info: Jan 20 00:11:32 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:32 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:32 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:11:32 volumio volumio[1042]: info: Jan 20 00:11:32 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:32 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:32 volumio volumio[1042]: info: ------------------------------ 0ms Jan 20 00:11:32 volumio volumio[1042]: info: Jan 20 00:11:32 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:32 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:32 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:32 volumio volumio[1042]: info: Jan 20 00:11:32 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:32 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:32 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:32 volumio volumio[1042]: info: Jan 20 00:11:32 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:32 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:32 volumio volumio[1042]: info: Jan 20 00:11:32 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:32 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:32 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:11:32 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:32 volumio volumio[1042]: info: Jan 20 00:11:32 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:32 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:32 volumio volumio[1042]: info: Jan 20 00:11:32 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:32 volumio volumio[1042]: info: sendMpdCommand status took 3 milliseconds Jan 20 00:11:32 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:32 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:32 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:11:32 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 00:11:32 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:32 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:32 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:32 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:32 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":429,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Shapes in the Spray","artist":"Klangphonics (Performer), Klangphonics (Performer), Klangphonics (Performer), Klangphonics (Performer)","album":"Shapes in the Spray","uri":"http://192.168.100.12:10246/MDEServer/CB5F9894-FF0E-44DF-9941-63CE493DAEE6/1000.flac","trackType":"flac"} Jan 20 00:11:32 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:11:32 volumio volumio[1042]: info: ------------------------------ 6ms Jan 20 00:11:32 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 00:11:32 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:32 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:32 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:32 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":429,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Shapes in the Spray","artist":"Klangphonics (Performer), Klangphonics (Performer), Klangphonics (Performer), Klangphonics (Performer)","album":"Shapes in the Spray","uri":"http://192.168.100.12:10246/MDEServer/CB5F9894-FF0E-44DF-9941-63CE493DAEE6/1000.flac","trackType":"flac"} Jan 20 00:11:32 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:11:32 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:32 volumio volumio[1042]: info: ------------------------------ 16ms Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:32 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:32 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:32 volumio volumio[1042]: info: Jan 20 00:11:32 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:32 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:32 volumio volumio[1042]: info: Jan 20 00:11:32 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:32 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:32 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:11:32 volumio volumio[1042]: info: sendMpdCommand status took 3 milliseconds Jan 20 00:11:32 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:32 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:32 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 00:11:32 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:32 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:32 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:32 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65,"duration":429,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1684 Kbps","isStreaming":false,"title":"Shapes in the Spray","artist":"Klangphonics","album":"Shapes in the Spray","uri":"http://192.168.100.12:10246/MDEServer/CB5F9894-FF0E-44DF-9941-63CE493DAEE6/1000.flac","trackType":"flac"} Jan 20 00:11:32 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:11:32 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:32 volumio volumio[1042]: info: ------------------------------ 24ms Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:32 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:32 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:32 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:32 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:34 volumio volumio[1042]: info: Clearing queue after UPNP request Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::stop Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Jan 20 00:11:34 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:34 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:34 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:34 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::serviceStop Jan 20 00:11:34 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:34 volumio volumio[1042]: info: ControllerMpd::stop Jan 20 00:11:34 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 00:11:34 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Jan 20 00:11:34 volumio volumio[1042]: info: CorePlayQueue::saveQueue Jan 20 00:11:34 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:34 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Jan 20 00:11:34 volumio volumio[1042]: info: Jan 20 00:11:34 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:34 volumio volumio[1042]: info: sendMpdCommand stop took 11 milliseconds Jan 20 00:11:34 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:34 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:34 volumio volumio[1042]: info: Jan 20 00:11:34 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:34 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:34 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:11:34 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:34 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:34 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:34 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:34 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:34 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:34 volumio volumio[1042]: 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} Jan 20 00:11:34 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::syncState stateService stop Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:34 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:34 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:34 volumio volumio[1042]: info: No code Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:34 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:34 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:34 volumio volumio[1042]: info: ------------------------------ 17ms Jan 20 00:11:34 volumio volumio[1042]: error: updateQueue error: null Jan 20 00:11:34 volumio volumio[1042]: info: ------------------------------ 17ms Jan 20 00:11:34 volumio volumio[1042]: info: Starting UPNP Playback Jan 20 00:11:34 volumio volumio[1042]: info: Preparing playback through UPNP Jan 20 00:11:34 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Jan 20 00:11:34 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:11:34 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 20 00:11:35 volumio volumio[1042]: info: Jan 20 00:11:35 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:35 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:35 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:35 volumio volumio[1042]: info: Jan 20 00:11:35 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:35 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:35 volumio volumio[1042]: info: Jan 20 00:11:35 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:35 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:35 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:11:35 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:35 volumio volumio[1042]: info: Jan 20 00:11:35 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:35 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:35 volumio volumio[1042]: info: Jan 20 00:11:35 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:35 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:35 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:35 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:35 volumio volumio[1042]: info: Jan 20 00:11:35 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:35 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:35 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:11:35 volumio volumio[1042]: info: Jan 20 00:11:35 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:35 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:35 volumio volumio[1042]: info: Jan 20 00:11:35 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:35 volumio volumio[1042]: info: sendMpdCommand status took 16 milliseconds Jan 20 00:11:35 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:35 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:35 volumio volumio[1042]: info: sendMpdCommand status took 2 milliseconds Jan 20 00:11:35 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 00:11:35 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:35 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:35 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:35 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:35 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":152,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"PS5","artist":"salem ilese (Performer), salem ilese (Performer), salem ilese (Performer), salem ilese (Performer), salem ilese (Performer), salem ilese (Performer)","album":"Unsponsored Content","uri":"http://192.168.100.12:10246/MDEServer/CD0014BD-479F-4BE1-A0EA-2885C43B729D/1000.flac","trackType":"flac"} Jan 20 00:11:35 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:11:35 volumio volumio[1042]: info: ------------------------------ 20ms Jan 20 00:11:35 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 00:11:35 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:35 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:35 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:35 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":152,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"PS5","artist":"salem ilese (Performer), salem ilese (Performer), salem ilese (Performer), salem ilese (Performer), salem ilese (Performer), salem ilese (Performer)","album":"Unsponsored Content","uri":"http://192.168.100.12:10246/MDEServer/CD0014BD-479F-4BE1-A0EA-2885C43B729D/1000.flac","trackType":"flac"} Jan 20 00:11:35 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:11:35 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:35 volumio volumio[1042]: info: ------------------------------ 20ms Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:35 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:35 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:35 volumio volumio[1042]: info: Jan 20 00:11:35 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:11:35 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:11:35 volumio volumio[1042]: info: Jan 20 00:11:35 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:11:35 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:11:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:11:35 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:11:35 volumio volumio[1042]: info: sendMpdCommand status took 2 milliseconds Jan 20 00:11:35 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:11:35 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:11:35 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 20 00:11:35 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:11:35 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:11:35 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:11:35 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7,"duration":152,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4657 Kbps","isStreaming":false,"title":"PS5","artist":"salem ilese","album":"Unsponsored Content","uri":"http://192.168.100.12:10246/MDEServer/CD0014BD-479F-4BE1-A0EA-2885C43B729D/1000.flac","trackType":"flac"} Jan 20 00:11:35 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:11:35 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:35 volumio volumio[1383]: Connection was closed while sending response headers. Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:11:35 volumio volumio[1042]: info: ------------------------------ 30ms Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:35 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:35 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:11:35 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:11:35 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:11:38 volumio ntpd[770]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 20 00:12:07 volumio volumio[1042]: info: Clearing queue after UPNP request Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::stop Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Jan 20 00:12:07 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:07 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:07 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:12:07 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::serviceStop Jan 20 00:12:07 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:07 volumio volumio[1042]: info: ControllerMpd::stop Jan 20 00:12:07 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 00:12:07 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Jan 20 00:12:07 volumio volumio[1042]: info: CorePlayQueue::saveQueue Jan 20 00:12:07 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:07 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Jan 20 00:12:07 volumio volumio[1042]: info: Jan 20 00:12:07 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:07 volumio volumio[1042]: info: sendMpdCommand stop took 28 milliseconds Jan 20 00:12:07 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:07 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:07 volumio volumio[1042]: info: Jan 20 00:12:07 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:07 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:07 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:12:07 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:07 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:07 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:07 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:07 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:07 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:07 volumio volumio[1042]: 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} Jan 20 00:12:07 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::syncState stateService stop Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:07 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:07 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:07 volumio volumio[1042]: info: No code Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:07 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:07 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:07 volumio volumio[1042]: info: ------------------------------ 19ms Jan 20 00:12:07 volumio volumio[1042]: error: updateQueue error: null Jan 20 00:12:07 volumio volumio[1042]: info: ------------------------------ 20ms Jan 20 00:12:07 volumio volumio[1042]: info: Starting UPNP Playback Jan 20 00:12:07 volumio volumio[1042]: info: Preparing playback through UPNP Jan 20 00:12:07 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Jan 20 00:12:07 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:07 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 20 00:12:08 volumio volumio[1042]: info: Jan 20 00:12:08 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:08 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:08 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:08 volumio volumio[1042]: info: Jan 20 00:12:08 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:08 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:08 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:08 volumio volumio[1042]: info: Jan 20 00:12:08 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:08 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:08 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:12:08 volumio volumio[1042]: info: Jan 20 00:12:08 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:08 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:08 volumio volumio[1042]: info: Jan 20 00:12:08 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:08 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:08 volumio volumio[1042]: info: ------------------------------ 4ms Jan 20 00:12:08 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:08 volumio volumio[1042]: info: Jan 20 00:12:08 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:08 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:08 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:08 volumio volumio[1042]: info: Jan 20 00:12:08 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:08 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:08 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:08 volumio volumio[1042]: info: Jan 20 00:12:08 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:08 volumio volumio[1042]: info: sendMpdCommand status took 31 milliseconds Jan 20 00:12:08 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:08 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:08 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:08 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:12:08 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:12:08 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 00:12:08 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:08 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:12:08 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:12:08 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:08 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:12:08 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":152,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"PS5","artist":"salem ilese (Performer), salem ilese (Performer), salem ilese (Performer), salem ilese (Performer), salem ilese (Performer), salem ilese (Performer)","album":"Unsponsored Content","uri":"http://192.168.100.12:10246/MDEServer/683B3886-3667-483C-B226-95493D1DA205/1000.flac","trackType":"flac"} Jan 20 00:12:08 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:12:08 volumio volumio[1042]: info: ------------------------------ 36ms Jan 20 00:12:08 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 20 00:12:08 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:12:08 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:08 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:12:08 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":152,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"PS5","artist":"salem ilese (Performer), salem ilese (Performer), salem ilese (Performer), salem ilese (Performer), salem ilese (Performer), salem ilese (Performer)","album":"Unsponsored Content","uri":"http://192.168.100.12:10246/MDEServer/683B3886-3667-483C-B226-95493D1DA205/1000.flac","trackType":"flac"} Jan 20 00:12:08 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:12:08 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:08 volumio volumio[1042]: info: ------------------------------ 21ms Jan 20 00:12:08 volumio volumio[1042]: info: Jan 20 00:12:08 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:08 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:08 volumio volumio[1042]: info: Jan 20 00:12:08 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:08 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:08 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:08 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:08 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:08 volumio volumio[1042]: info: ------------------------------ 5ms Jan 20 00:12:08 volumio volumio[1042]: info: sendMpdCommand status took 5 milliseconds Jan 20 00:12:08 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:08 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:12:08 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 20 00:12:08 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:12:08 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:08 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:12:08 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":330,"duration":152,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5229 Kbps","isStreaming":false,"title":"PS5","artist":"salem ilese","album":"Unsponsored Content","uri":"http://192.168.100.12:10246/MDEServer/683B3886-3667-483C-B226-95493D1DA205/1000.flac","trackType":"flac"} Jan 20 00:12:08 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:12:08 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:08 volumio volumio[1042]: info: ------------------------------ 25ms Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:08 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:08 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:08 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:08 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:27 volumio volumio[1042]: info: Clearing queue after UPNP request Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::stop Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Jan 20 00:12:27 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:27 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::serviceStop Jan 20 00:12:27 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:27 volumio volumio[1042]: info: ControllerMpd::stop Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 00:12:27 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Jan 20 00:12:27 volumio volumio[1042]: info: CorePlayQueue::saveQueue Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Jan 20 00:12:27 volumio volumio[1042]: info: Jan 20 00:12:27 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:27 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:27 volumio volumio[1042]: info: Jan 20 00:12:27 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:27 volumio volumio[1042]: info: sendMpdCommand stop took 21 milliseconds Jan 20 00:12:27 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:27 volumio volumio[1042]: error: updateQueue error: null Jan 20 00:12:27 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:12:27 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:27 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:27 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:27 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:27 volumio volumio[1042]: 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} Jan 20 00:12:27 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::syncState stateService stop Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:27 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:27 volumio volumio[1042]: info: No code Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:27 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:27 volumio volumio[1042]: info: ------------------------------ 14ms Jan 20 00:12:27 volumio volumio[1042]: info: Starting UPNP Playback Jan 20 00:12:27 volumio volumio[1042]: info: Preparing playback through UPNP Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Jan 20 00:12:27 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 20 00:12:27 volumio volumio[1042]: info: Jan 20 00:12:27 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:27 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:27 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:27 volumio volumio[1042]: info: Jan 20 00:12:27 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:27 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:27 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:27 volumio volumio[1042]: info: Jan 20 00:12:27 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:27 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:27 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:27 volumio volumio[1042]: info: Jan 20 00:12:27 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:27 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:27 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:27 volumio volumio[1042]: info: Jan 20 00:12:27 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:27 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:27 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:27 volumio volumio[1042]: info: Jan 20 00:12:27 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:27 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:27 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:12:27 volumio volumio[1042]: info: Jan 20 00:12:27 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:27 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:27 volumio volumio[1042]: info: Jan 20 00:12:27 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:27 volumio volumio[1042]: info: sendMpdCommand status took 53 milliseconds Jan 20 00:12:27 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:12:27 volumio volumio[1042]: info: Jan 20 00:12:27 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:27 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:27 volumio volumio[1042]: info: Jan 20 00:12:27 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:27 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:27 volumio volumio[1042]: info: sendMpdCommand status took 5 milliseconds Jan 20 00:12:27 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 20 00:12:27 volumio volumio[1042]: info: ------------------------------ 4ms Jan 20 00:12:27 volumio volumio[1042]: info: sendMpdCommand status took 4 milliseconds Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:12:27 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:27 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:12:27 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":152,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"PS5","artist":"salem ilese","album":"Unsponsored Content","uri":"http://192.168.100.12:10246/MDEServer/F47FFAB6-8F6F-4B8A-9F28-760007280E7C/1000.flac","trackType":"flac"} Jan 20 00:12:27 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:12:27 volumio volumio[1042]: info: ------------------------------ 63ms Jan 20 00:12:27 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:12:27 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:27 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:12:27 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13,"duration":152,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5149 Kbps","isStreaming":false,"title":"PS5","artist":"salem ilese","album":"Unsponsored Content","uri":"http://192.168.100.12:10246/MDEServer/F47FFAB6-8F6F-4B8A-9F28-760007280E7C/1000.flac","trackType":"flac"} Jan 20 00:12:27 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:12:27 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:27 volumio volumio[1042]: info: ------------------------------ 31ms Jan 20 00:12:27 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 24 milliseconds Jan 20 00:12:27 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:12:27 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:27 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:12:27 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":18,"duration":152,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5149 Kbps","isStreaming":false,"title":"PS5","artist":"salem ilese","album":"Unsponsored Content","uri":"http://192.168.100.12:10246/MDEServer/F47FFAB6-8F6F-4B8A-9F28-760007280E7C/1000.flac","trackType":"flac"} Jan 20 00:12:27 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:12:27 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:27 volumio volumio[1042]: info: ------------------------------ 54ms Jan 20 00:12:27 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:28 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:28 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:28 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:28 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:28 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:28 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:28 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:28 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:28 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:28 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:28 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:29 volumio volumio[1042]: info: Jan 20 00:12:29 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:29 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:29 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:29 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:12:29 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:29 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:12:29 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 20 00:12:29 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:12:29 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:29 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:29 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:12:29 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":152,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5162 Kbps","isStreaming":false,"title":"PS5","artist":"salem ilese","album":"Unsponsored Content","uri":"http://192.168.100.12:10246/MDEServer/F47FFAB6-8F6F-4B8A-9F28-760007280E7C/1000.flac","trackType":"flac"} Jan 20 00:12:29 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:29 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:12:29 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:12:29 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:12:29 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:12:29 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:29 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:12:29 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:29 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:29 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:30 volumio volumio[1042]: info: ------------------------------ 18ms Jan 20 00:12:30 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:30 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:30 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:30 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:30 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:30 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:30 volumio volumio[1042]: info: Jan 20 00:12:30 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:30 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:30 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:30 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:12:30 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:30 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:12:30 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 20 00:12:30 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:12:30 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:30 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:30 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:12:30 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":152,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5074 Kbps","isStreaming":false,"title":"PS5","artist":"salem ilese","album":"Unsponsored Content","uri":"http://192.168.100.12:10246/MDEServer/F47FFAB6-8F6F-4B8A-9F28-760007280E7C/1000.flac","trackType":"flac"} Jan 20 00:12:30 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:30 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:12:30 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:12:30 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:12:30 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:12:30 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:30 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:12:30 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:30 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:30 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:30 volumio volumio[1042]: info: ------------------------------ 17ms Jan 20 00:12:30 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:30 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:30 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:30 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:30 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:30 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:37 volumio volumio[1042]: info: Clearing queue after UPNP request Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::ClearQueue Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::stop Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::stPlaybackTimer Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::updateTrackBlock Jan 20 00:12:37 volumio volumio[1042]: info: CorePlayQueue::getTrackBlock Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:37 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:37 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:12:37 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::serviceStop Jan 20 00:12:37 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:37 volumio volumio[1042]: info: ControllerMpd::stop Jan 20 00:12:37 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 00:12:37 volumio volumio[1042]: info: CorePlayQueue::clearPlayQueue Jan 20 00:12:37 volumio volumio[1042]: info: CorePlayQueue::saveQueue Jan 20 00:12:37 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:37 volumio volumio[1042]: info: CoreCommandRouter::volumioPushQueue Jan 20 00:12:37 volumio volumio[1042]: info: sendMpdCommand stop took 19 milliseconds Jan 20 00:12:37 volumio volumio[1042]: info: Jan 20 00:12:37 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:37 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:37 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:37 volumio volumio[1042]: info: Jan 20 00:12:37 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:37 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:37 volumio volumio[1042]: info: sendMpdCommand status took 1 milliseconds Jan 20 00:12:37 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:37 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:37 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:37 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:37 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:37 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:37 volumio volumio[1042]: 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} Jan 20 00:12:37 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::syncState stateService stop Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:37 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:37 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:37 volumio volumio[1042]: info: No code Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:37 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:37 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:37 volumio volumio[1042]: info: ------------------------------ 13ms Jan 20 00:12:37 volumio volumio[1042]: error: updateQueue error: null Jan 20 00:12:37 volumio volumio[1042]: info: ------------------------------ 14ms Jan 20 00:12:37 volumio volumio[1042]: info: Starting UPNP Playback Jan 20 00:12:37 volumio volumio[1042]: info: Preparing playback through UPNP Jan 20 00:12:37 volumio volumio[1042]: info: CoreCommandRouter::volumioGetState Jan 20 00:12:37 volumio volumio[1042]: info: CorePlayQueue::getTrack 0 Jan 20 00:12:37 volumio volumio[1042]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 20 00:12:37 volumio volumio[1042]: info: Jan 20 00:12:37 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:37 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:37 volumio volumio[1042]: info: ------------------------------ 0ms Jan 20 00:12:37 volumio volumio[1042]: info: Jan 20 00:12:37 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:37 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:37 volumio volumio[1042]: info: Jan 20 00:12:37 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:37 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:37 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:37 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:37 volumio volumio[1042]: info: Jan 20 00:12:37 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:37 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:37 volumio volumio[1042]: info: Jan 20 00:12:37 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:37 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:37 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:37 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:37 volumio volumio[1042]: info: Jan 20 00:12:37 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:37 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:37 volumio volumio[1042]: info: ------------------------------ 1ms Jan 20 00:12:38 volumio volumio[1042]: info: Jan 20 00:12:38 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:38 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:38 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:38 volumio volumio[1042]: info: Jan 20 00:12:38 volumio volumio[1042]: ---------------------------- MPD announces system playlist update Jan 20 00:12:38 volumio volumio[1042]: info: Ignoring MPD Status Update Jan 20 00:12:38 volumio volumio[1042]: info: Jan 20 00:12:38 volumio volumio[1042]: ---------------------------- MPD announces state update: player Jan 20 00:12:38 volumio volumio[1042]: info: sendMpdCommand status took 24 milliseconds Jan 20 00:12:38 volumio volumio[1042]: info: ControllerMpd::getState Jan 20 00:12:38 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand status Jan 20 00:12:38 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:38 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:12:38 volumio volumio[1042]: info: ------------------------------ 2ms Jan 20 00:12:38 volumio volumio[1042]: info: sendMpdCommand status took 2 milliseconds Jan 20 00:12:38 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 20 00:12:38 volumio volumio[1042]: verbose: ControllerMpd::parseState Jan 20 00:12:38 volumio volumio[1042]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 00:12:38 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:12:38 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:38 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:38 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:12:38 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":157,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"SOS","artist":"Avicii/Aloe Blacc","album":"SOS","uri":"http://192.168.100.12:10246/MDEServer/20B5DAC7-59D0-4583-A234-DF50E60C4EF8/1000.flac","trackType":"flac"} Jan 20 00:12:38 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:38 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:12:38 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus stop Jan 20 00:12:38 volumio volumio[1042]: info: ------------------------------ 29ms Jan 20 00:12:38 volumio volumio[1042]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 20 00:12:38 volumio volumio[1042]: verbose: ControllerMpd::parseTrackInfo Jan 20 00:12:38 volumio volumio[1042]: info: ControllerMpd::pushState Jan 20 00:12:38 volumio volumio[1042]: info: CoreCommandRouter::servicePushState Jan 20 00:12:38 volumio volumio[1042]: verbose: In UPNP mode Jan 20 00:12:38 volumio volumio[1042]: verbose: STATE SERVICE {"status":"play","position":0,"seek":241,"duration":157,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2589 Kbps","isStreaming":false,"title":"SOS","artist":"Avicii/Aloe Blacc","album":"SOS","uri":"http://192.168.100.12:10246/MDEServer/20B5DAC7-59D0-4583-A234-DF50E60C4EF8/1000.flac","trackType":"flac"} Jan 20 00:12:38 volumio volumio[1042]: verbose: CURRENT POSITION 0 Jan 20 00:12:38 volumio volumio[1042]: info: CoreStateMachine::syncState stateService play Jan 20 00:12:38 volumio volumio[1042]: info: CoreStateMachine::syncState currentStatus play Jan 20 00:12:38 volumio volumio[1042]: info: Received an update from plugin. extracting info from payload Jan 20 00:12:38 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 00:12:38 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:38 volumio volumio[1042]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 00:12:38 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:38 volumio volumio[1042]: info: CoreStateMachine::pushState Jan 20 00:12:38 volumio volumio[1042]: info: CoreCommandRouter::volumioPushState Jan 20 00:12:38 volumio volumio[1042]: info: ------------------------------ 16ms Jan 20 00:12:38 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:38 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:38 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:38 volumio volumio[1042]: info: CoreCommandRouter::volumioGetQueue Jan 20 00:12:38 volumio volumio[1042]: info: CoreStateMachine::getQueue Jan 20 00:12:38 volumio volumio[1042]: info: CorePlayQueue::getQueue Jan 20 00:12:43 volumio volumio[1042]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 00:12:43 volumio volumio[1042]: Error: connect ETIMEDOUT 108.160.165.147:443 Jan 20 00:12:43 volumio volumio[1042]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jan 20 00:12:43 volumio volumio[1042]: errno: -110, Jan 20 00:12:43 volumio volumio[1042]: code: 'ETIMEDOUT', Jan 20 00:12:43 volumio volumio[1042]: syscall: 'connect', Jan 20 00:12:43 volumio volumio[1042]: address: '108.160.165.147', Jan 20 00:12:43 volumio volumio[1042]: port: 443 Jan 20 00:12:43 volumio volumio[1042]: } Jan 20 00:12:43 volumio volumio[1042]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 00:12:44 volumio sudo[5969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 00:11 Jan 20 00:12:44 volumio sudo[5969]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"