-- Logs begin at Thu 2025-07-17 12:43:37 UTC, end at Thu 2025-07-17 13:41:59 UTC. -- Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::ClearQueue Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::stop Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:02 volumio volumio[1724]: verbose: UNSET VOLATILE Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::stPlaybackTimer Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::updateTrackBlock Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::getTrackBlock Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::serviceStop Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::serviceStop Jul 17 13:40:02 volumio volumio[1724]: info: [1752759602409] ControllerWebradio::stop Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::clearPlayQueue Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::saveQueue Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::volumioPushQueue Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::addQueueItems Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::addQueueItems Jul 17 13:40:02 volumio volumio[1724]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497966 Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::saveQueue Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::volumioPushQueue Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::updateTrackBlock Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::getTrackBlock Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::volumioPlay Jul 17 13:40:02 volumio volumio[1724]: verbose: UNSET VOLATILE Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::play index 0 Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::stop Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:02 volumio volumio[1724]: verbose: UNSET VOLATILE Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::play index undefined Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::startPlaybackTimer Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:02 volumio volumio[1724]: info: [1752759602429] ControllerWebradio::clearAddPlayTrack Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 13:40:02 volumio volumio[1724]: info: Jul 17 13:40:02 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:02 volumio volumio[1724]: info: sendMpdCommand stop took 24 milliseconds Jul 17 13:40:02 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:02 volumio volumio[1724]: info: sendMpdCommand stop took 4 milliseconds Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 13:40:02 volumio volumio[1724]: info: Jul 17 13:40:02 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:02 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:02 volumio volumio[1724]: info: Jul 17 13:40:02 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:02 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:02 volumio volumio[1724]: info: Jul 17 13:40:02 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:02 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:02 volumio volumio[1724]: info: sendMpdCommand status took 4 milliseconds Jul 17 13:40:02 volumio volumio[1724]: info: sendMpdCommand clear took 3 milliseconds Jul 17 13:40:02 volumio volumio[1724]: info: sendMpdCommand status took 3 milliseconds Jul 17 13:40:02 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497966" Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:02 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:02 volumio volumio[1724]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 17 13:40:02 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:02 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:02 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:02 volumio volumio[1724]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 17 13:40:02 volumio volumio[1724]: info: ------------------------------ 19ms Jul 17 13:40:02 volumio volumio[1724]: info: Jul 17 13:40:02 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:02 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:02 volumio volumio[1724]: info: Jul 17 13:40:02 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:02 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:02 volumio volumio[1724]: error: updateQueue error: null Jul 17 13:40:02 volumio volumio[1724]: info: ------------------------------ 21ms Jul 17 13:40:02 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 19 milliseconds Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:02 volumio volumio[1724]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 13:40:02 volumio volumio[1724]: info: ------------------------------ 27ms Jul 17 13:40:02 volumio volumio[1724]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497966" took 289 milliseconds Jul 17 13:40:02 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 17 13:40:02 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand play Jul 17 13:40:02 volumio volumio[1724]: info: Jul 17 13:40:02 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:02 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:02 volumio volumio[1724]: info: ------------------------------ 274ms Jul 17 13:40:02 volumio volumio[1724]: info: ------------------------------ 274ms Jul 17 13:40:02 volumio volumio[1724]: info: Jul 17 13:40:02 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:02 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:02 volumio volumio[1724]: info: Jul 17 13:40:02 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:02 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:02 volumio volumio[1724]: info: sendMpdCommand play took 4 milliseconds Jul 17 13:40:02 volumio volumio[1724]: info: ------------------------------ 4ms Jul 17 13:40:02 volumio volumio[1724]: info: ------------------------------ 2ms Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::ClearQueue Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::stop Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:09 volumio volumio[1724]: verbose: UNSET VOLATILE Jul 17 13:40:09 volumio volumio[1724]: info: CorePlayQueue::clearPlayQueue Jul 17 13:40:09 volumio volumio[1724]: info: CorePlayQueue::saveQueue Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::volumioPushQueue Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::addQueueItems Jul 17 13:40:09 volumio volumio[1724]: info: CorePlayQueue::addQueueItems Jul 17 13:40:09 volumio volumio[1724]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=453423 Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 17 13:40:09 volumio volumio[1724]: info: CorePlayQueue::saveQueue Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::volumioPushQueue Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::updateTrackBlock Jul 17 13:40:09 volumio volumio[1724]: info: CorePlayQueue::getTrackBlock Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::volumioPlay Jul 17 13:40:09 volumio volumio[1724]: verbose: UNSET VOLATILE Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::play index 0 Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::stop Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:09 volumio volumio[1724]: verbose: UNSET VOLATILE Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::play index undefined Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:09 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::startPlaybackTimer Jul 17 13:40:09 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:09 volumio volumio[1724]: info: [1752759609355] ControllerWebradio::clearAddPlayTrack Jul 17 13:40:09 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 13:40:09 volumio volumio[1724]: info: Jul 17 13:40:09 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:09 volumio volumio[1724]: info: sendMpdCommand stop took 4 milliseconds Jul 17 13:40:09 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:09 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:09 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 13:40:09 volumio volumio[1724]: info: Jul 17 13:40:09 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:09 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:09 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:09 volumio volumio[1724]: info: sendMpdCommand clear took 2 milliseconds Jul 17 13:40:09 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:09 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:09 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=453423" Jul 17 13:40:09 volumio volumio[1724]: info: Jul 17 13:40:09 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:09 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:09 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:09 volumio volumio[1724]: info: Jul 17 13:40:09 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:09 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:09 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:09 volumio volumio[1724]: error: updateQueue error: null Jul 17 13:40:09 volumio volumio[1724]: info: ------------------------------ 5ms Jul 17 13:40:09 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 17 13:40:09 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:09 volumio volumio[1724]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 13:40:09 volumio volumio[1724]: info: ------------------------------ 9ms Jul 17 13:40:09 volumio volumio[1724]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=453423" took 266 milliseconds Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 17 13:40:09 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand play Jul 17 13:40:09 volumio volumio[1724]: info: Jul 17 13:40:09 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:09 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:09 volumio volumio[1724]: info: sendMpdCommand status took 268 milliseconds Jul 17 13:40:09 volumio volumio[1724]: info: sendMpdCommand status took 266 milliseconds Jul 17 13:40:09 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:09 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:09 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:09 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:09 volumio volumio[1724]: 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} Jul 17 13:40:09 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::syncState stateService stop Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus stop Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:09 volumio volumio[1724]: info: No code Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:09 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:09 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:09 volumio volumio[1724]: 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} Jul 17 13:40:09 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::syncState stateService stop Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus stop Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:09 volumio volumio[1724]: info: No code Jul 17 13:40:09 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:09 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:09 volumio volumio[1724]: info: ------------------------------ 300ms Jul 17 13:40:09 volumio volumio[1724]: info: ------------------------------ 300ms Jul 17 13:40:09 volumio volumio[1724]: info: Jul 17 13:40:09 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:09 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:09 volumio volumio[1724]: info: Jul 17 13:40:09 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:09 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:09 volumio volumio[1724]: info: sendMpdCommand play took 37 milliseconds Jul 17 13:40:09 volumio volumio[1724]: info: ------------------------------ 36ms Jul 17 13:40:09 volumio volumio[1724]: info: ------------------------------ 2ms Jul 17 13:40:09 volumio volumio[1724]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/ROCK%20ANTENNE/c0f8a208-ea20-45b6-8f74-8a484b77d45e.jpg' Jul 17 13:40:11 volumio volumio[1724]: info: Jul 17 13:40:11 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:11 volumio volumio[1724]: info: Jul 17 13:40:11 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:11 volumio volumio[1724]: info: Jul 17 13:40:11 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:11 volumio volumio[1724]: info: Jul 17 13:40:11 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:11 volumio volumio[1724]: info: Jul 17 13:40:11 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:11 volumio volumio[1724]: info: Jul 17 13:40:11 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand status took 5 milliseconds Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand status took 4 milliseconds Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand status took 3 milliseconds Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand status took 5 milliseconds Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand status took 4 milliseconds Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 1160/2000) RADIO 1 MANELE ROMANIA - wWw.RadioUnuManele.CoM HOSTAT de HostClean.Ro","album":null,"uri":"http://54.39.28.158:8000/stream","trackType":""} Jul 17 13:40:11 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus stop Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 1160/2000) RADIO 1 MANELE ROMANIA - wWw.RadioUnuManele.CoM HOSTAT de HostClean.Ro","album":null,"uri":"http://54.39.28.158:8000/stream","trackType":""} Jul 17 13:40:11 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:11 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 1160/2000) RADIO 1 MANELE ROMANIA - wWw.RadioUnuManele.CoM HOSTAT de HostClean.Ro","album":null,"uri":"http://54.39.28.158:8000/stream","trackType":""} Jul 17 13:40:11 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:11 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 1160/2000) RADIO 1 MANELE ROMANIA - wWw.RadioUnuManele.CoM HOSTAT de HostClean.Ro","album":null,"uri":"http://54.39.28.158:8000/stream","trackType":""} Jul 17 13:40:11 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:11 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: ------------------------------ 48ms Jul 17 13:40:11 volumio volumio[1724]: info: ------------------------------ 47ms Jul 17 13:40:11 volumio volumio[1724]: info: ------------------------------ 46ms Jul 17 13:40:11 volumio volumio[1724]: info: ------------------------------ 46ms Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 41 milliseconds Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 41 milliseconds Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 1160/2000) RADIO 1 MANELE ROMANIA - wWw.RadioUnuManele.CoM HOSTAT de HostClean.Ro","album":null,"uri":"http://54.39.28.158:8000/stream","trackType":""} Jul 17 13:40:11 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:11 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 1160/2000) RADIO 1 MANELE ROMANIA - wWw.RadioUnuManele.CoM HOSTAT de HostClean.Ro","album":null,"uri":"http://54.39.28.158:8000/stream","trackType":""} Jul 17 13:40:11 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:11 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: ------------------------------ 78ms Jul 17 13:40:11 volumio volumio[1724]: info: ------------------------------ 78ms Jul 17 13:40:11 volumio volumio[1724]: info: Jul 17 13:40:11 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:11 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:11 volumio volumio[1724]: info: Jul 17 13:40:11 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:11 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:11 volumio volumio[1724]: info: Jul 17 13:40:11 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:11 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:11 volumio volumio[1724]: info: Jul 17 13:40:11 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:11 volumio volumio[1724]: info: ------------------------------ 5ms Jul 17 13:40:11 volumio volumio[1724]: info: ------------------------------ 5ms Jul 17 13:40:11 volumio volumio[1724]: info: Jul 17 13:40:11 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:11 volumio volumio[1724]: info: Jul 17 13:40:11 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:11 volumio volumio[1724]: info: ------------------------------ 8ms Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand status took 4 milliseconds Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand status took 3 milliseconds Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand status took 3 milliseconds Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"RADIO 1 MANELE ROMANIA - wWw.RadioUnuManele.CoM HOSTAT de HostClean.Ro","album":null,"uri":"http://54.39.28.158:8000/stream","trackType":""} Jul 17 13:40:11 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:11 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"RADIO 1 MANELE ROMANIA - wWw.RadioUnuManele.CoM HOSTAT de HostClean.Ro","album":null,"uri":"http://54.39.28.158:8000/stream","trackType":""} Jul 17 13:40:11 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:11 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: ------------------------------ 25ms Jul 17 13:40:11 volumio volumio[1724]: info: ------------------------------ 24ms Jul 17 13:40:11 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 19 milliseconds Jul 17 13:40:11 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:11 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"RADIO 1 MANELE ROMANIA - wWw.RadioUnuManele.CoM HOSTAT de HostClean.Ro","album":null,"uri":"http://54.39.28.158:8000/stream","trackType":""} Jul 17 13:40:11 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:11 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:11 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:11 volumio volumio[1724]: info: ------------------------------ 35ms Jul 17 13:40:12 volumio volumio[1724]: info: Jul 17 13:40:12 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:12 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:12 volumio volumio[1724]: info: Jul 17 13:40:12 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:12 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:12 volumio volumio[1724]: info: Jul 17 13:40:12 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:12 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:12 volumio volumio[1724]: info: Jul 17 13:40:12 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:12 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:12 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:12 volumio volumio[1724]: info: ------------------------------ 2ms Jul 17 13:40:12 volumio volumio[1724]: info: ------------------------------ 2ms Jul 17 13:40:12 volumio volumio[1724]: info: ------------------------------ 2ms Jul 17 13:40:12 volumio volumio[1724]: info: Jul 17 13:40:12 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:12 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:12 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:12 volumio volumio[1724]: info: Jul 17 13:40:12 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:12 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:12 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:12 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:12 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:12 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:12 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:12 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:12 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:12 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:12 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 17 13:40:12 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 17 13:40:12 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:12 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:12 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:12 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:12 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:12 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:12 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:12 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1683,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nicolae Guta - Asta seara o fac lata","artist":"RADIO 1 MANELE ROMANIA - wWw.RadioUnuManele.CoM HOSTAT de HostClean.Ro","album":null,"uri":"http://54.39.28.158:8000/stream","trackType":""} Jul 17 13:40:12 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:12 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:12 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:12 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:12 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:12 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:12 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:12 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:12 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:12 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:12 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:12 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:12 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1683,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nicolae Guta - Asta seara o fac lata","artist":"RADIO 1 MANELE ROMANIA - wWw.RadioUnuManele.CoM HOSTAT de HostClean.Ro","album":null,"uri":"http://54.39.28.158:8000/stream","trackType":""} Jul 17 13:40:12 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:12 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:12 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:12 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:12 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:12 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:12 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:12 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:12 volumio volumio[1724]: info: ------------------------------ 22ms Jul 17 13:40:12 volumio volumio[1724]: info: ------------------------------ 22ms Jul 17 13:40:12 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 20 milliseconds Jul 17 13:40:12 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:12 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:12 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:12 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:12 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1683,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nicolae Guta - Asta seara o fac lata","artist":"RADIO 1 MANELE ROMANIA - wWw.RadioUnuManele.CoM HOSTAT de HostClean.Ro","album":null,"uri":"http://54.39.28.158:8000/stream","trackType":""} Jul 17 13:40:12 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:12 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:12 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:12 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:12 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:12 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:12 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:12 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:12 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:12 volumio volumio[1724]: info: ------------------------------ 35ms Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::ClearQueue Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::stop Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:28 volumio volumio[1724]: verbose: UNSET VOLATILE Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::stPlaybackTimer Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::updateTrackBlock Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::getTrackBlock Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::serviceStop Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::serviceStop Jul 17 13:40:28 volumio volumio[1724]: info: [1752759628170] ControllerWebradio::stop Jul 17 13:40:28 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::clearPlayQueue Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::saveQueue Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::volumioPushQueue Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::addQueueItems Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::addQueueItems Jul 17 13:40:28 volumio volumio[1724]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99613155 Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::saveQueue Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::volumioPushQueue Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::updateTrackBlock Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::getTrackBlock Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::volumioPlay Jul 17 13:40:28 volumio volumio[1724]: verbose: UNSET VOLATILE Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::play index 0 Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::stop Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:28 volumio volumio[1724]: verbose: UNSET VOLATILE Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::play index undefined Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::startPlaybackTimer Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:28 volumio volumio[1724]: info: [1752759628183] ControllerWebradio::clearAddPlayTrack Jul 17 13:40:28 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 13:40:28 volumio volumio[1724]: info: Jul 17 13:40:28 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:28 volumio volumio[1724]: info: sendMpdCommand stop took 21 milliseconds Jul 17 13:40:28 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:28 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:28 volumio volumio[1724]: info: sendMpdCommand stop took 7 milliseconds Jul 17 13:40:28 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 13:40:28 volumio volumio[1724]: info: Jul 17 13:40:28 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:28 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:28 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:28 volumio volumio[1724]: info: Jul 17 13:40:28 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:28 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:28 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:28 volumio volumio[1724]: info: Jul 17 13:40:28 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:28 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:28 volumio volumio[1724]: info: sendMpdCommand status took 3 milliseconds Jul 17 13:40:28 volumio volumio[1724]: info: sendMpdCommand clear took 3 milliseconds Jul 17 13:40:28 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:28 volumio volumio[1724]: info: sendMpdCommand status took 1 milliseconds Jul 17 13:40:28 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:28 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:28 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99613155" Jul 17 13:40:28 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:28 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:28 volumio volumio[1724]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 17 13:40:28 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:28 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:28 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:28 volumio volumio[1724]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 17 13:40:28 volumio volumio[1724]: info: ------------------------------ 20ms Jul 17 13:40:28 volumio volumio[1724]: info: ------------------------------ 21ms Jul 17 13:40:28 volumio volumio[1724]: info: Jul 17 13:40:28 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:28 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:28 volumio volumio[1724]: info: Jul 17 13:40:28 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:28 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:28 volumio volumio[1724]: error: updateQueue error: null Jul 17 13:40:28 volumio volumio[1724]: info: ------------------------------ 24ms Jul 17 13:40:28 volumio volumio[1724]: info: Jul 17 13:40:28 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:28 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:28 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 264 milliseconds Jul 17 13:40:28 volumio volumio[1724]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99613155" took 264 milliseconds Jul 17 13:40:28 volumio volumio[1724]: info: ------------------------------ 246ms Jul 17 13:40:28 volumio volumio[1724]: info: ------------------------------ 245ms Jul 17 13:40:28 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:28 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 17 13:40:28 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand play Jul 17 13:40:28 volumio volumio[1724]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 13:40:28 volumio volumio[1724]: info: ------------------------------ 271ms Jul 17 13:40:28 volumio volumio[1724]: info: Jul 17 13:40:28 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:28 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:28 volumio volumio[1724]: info: Jul 17 13:40:28 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:28 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:28 volumio volumio[1724]: info: ------------------------------ 4ms Jul 17 13:40:28 volumio volumio[1724]: info: sendMpdCommand play took 3 milliseconds Jul 17 13:40:28 volumio volumio[1724]: info: ------------------------------ 2ms Jul 17 13:40:28 volumio volumio[1724]: info: ------------------------------ 1ms Jul 17 13:40:32 volumio volumio[1724]: info: Jul 17 13:40:32 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:32 volumio volumio[1724]: info: Jul 17 13:40:32 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:32 volumio volumio[1724]: info: Jul 17 13:40:32 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:32 volumio volumio[1724]: info: Jul 17 13:40:32 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand status took 5 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand status took 5 milliseconds Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:32 volumio volumio[1724]: info: Jul 17 13:40:32 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:32 volumio volumio[1724]: info: Jul 17 13:40:32 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:32 volumio volumio[1724]: info: Jul 17 13:40:32 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:32 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:32 volumio volumio[1724]: info: Jul 17 13:40:32 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand status took 13 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand status took 11 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 10 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand status took 8 milliseconds Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"La Chismosa 2","album":null,"uri":"https://sp.dattavolt.com:8052/stream","trackType":""} Jul 17 13:40:32 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus stop Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"La Chismosa 2","album":null,"uri":"https://sp.dattavolt.com:8052/stream","trackType":""} Jul 17 13:40:32 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:32 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: ------------------------------ 39ms Jul 17 13:40:32 volumio volumio[1724]: info: ------------------------------ 38ms Jul 17 13:40:32 volumio volumio[1724]: info: Jul 17 13:40:32 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:32 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:32 volumio volumio[1724]: info: Jul 17 13:40:32 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:32 volumio volumio[1724]: info: Jul 17 13:40:32 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:32 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:32 volumio volumio[1724]: info: Jul 17 13:40:32 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand status took 29 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: ------------------------------ 28ms Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand status took 25 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 22 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 21 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 21 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: ------------------------------ 4ms Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand status took 3 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: ------------------------------ 3ms Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"La Chismosa 2","album":null,"uri":"https://sp.dattavolt.com:8052/stream","trackType":""} Jul 17 13:40:32 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:32 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"38 Kbps","isStreaming":false,"title":"stream","artist":"La Chismosa 2","album":null,"uri":"https://sp.dattavolt.com:8052/stream","trackType":""} Jul 17 13:40:32 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:32 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"38 Kbps","isStreaming":false,"title":"stream","artist":"La Chismosa 2","album":null,"uri":"https://sp.dattavolt.com:8052/stream","trackType":""} Jul 17 13:40:32 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:32 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: ------------------------------ 82ms Jul 17 13:40:32 volumio volumio[1724]: info: ------------------------------ 81ms Jul 17 13:40:32 volumio volumio[1724]: info: ------------------------------ 76ms Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 54 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 54 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 53 milliseconds Jul 17 13:40:32 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 53 milliseconds Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:32 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"38 Kbps","isStreaming":false,"title":"stream","artist":"La Chismosa 2","album":null,"uri":"https://sp.dattavolt.com:8052/stream","trackType":""} Jul 17 13:40:32 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:32 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"38 Kbps","isStreaming":false,"title":"stream","artist":"La Chismosa 2","album":null,"uri":"https://sp.dattavolt.com:8052/stream","trackType":""} Jul 17 13:40:32 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:32 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"38 Kbps","isStreaming":false,"title":"stream","artist":"La Chismosa 2","album":null,"uri":"https://sp.dattavolt.com:8052/stream","trackType":""} Jul 17 13:40:32 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:32 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"38 Kbps","isStreaming":false,"title":"stream","artist":"La Chismosa 2","album":null,"uri":"https://sp.dattavolt.com:8052/stream","trackType":""} Jul 17 13:40:32 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:32 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:32 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:32 volumio volumio[1724]: info: ------------------------------ 150ms Jul 17 13:40:32 volumio volumio[1724]: info: ------------------------------ 146ms Jul 17 13:40:32 volumio volumio[1724]: info: ------------------------------ 123ms Jul 17 13:40:32 volumio volumio[1724]: info: ------------------------------ 123ms Jul 17 13:40:37 volumio volumio[1724]: info: Jul 17 13:40:37 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:37 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:37 volumio volumio[1724]: info: Jul 17 13:40:37 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:37 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:37 volumio volumio[1724]: info: Jul 17 13:40:37 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:37 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:37 volumio volumio[1724]: info: Jul 17 13:40:37 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:37 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:37 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:37 volumio volumio[1724]: info: ------------------------------ 3ms Jul 17 13:40:37 volumio volumio[1724]: info: ------------------------------ 2ms Jul 17 13:40:37 volumio volumio[1724]: info: ------------------------------ 1ms Jul 17 13:40:37 volumio volumio[1724]: info: Jul 17 13:40:37 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:37 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:37 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:37 volumio volumio[1724]: info: Jul 17 13:40:37 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:37 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:37 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:37 volumio volumio[1724]: info: sendMpdCommand status took 3 milliseconds Jul 17 13:40:37 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:37 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:37 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:37 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:37 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:37 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:37 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 17 13:40:37 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 17 13:40:37 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:37 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:37 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:37 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:37 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:37 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:37 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":6283,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"38 Kbps","isStreaming":false,"title":"LA CHISMOSA","artist":"La Chismosa 2","album":null,"uri":"https://sp.dattavolt.com:8052/stream","trackType":""} Jul 17 13:40:37 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:37 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:37 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:37 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:37 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:37 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:37 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:37 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:37 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":6283,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"38 Kbps","isStreaming":false,"title":"LA CHISMOSA","artist":"La Chismosa 2","album":null,"uri":"https://sp.dattavolt.com:8052/stream","trackType":""} Jul 17 13:40:37 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:37 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:37 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:37 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:37 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:37 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:37 volumio volumio[1724]: info: ------------------------------ 28ms Jul 17 13:40:37 volumio volumio[1724]: info: ------------------------------ 27ms Jul 17 13:40:37 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 24 milliseconds Jul 17 13:40:37 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:37 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:37 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:37 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":6283,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"38 Kbps","isStreaming":false,"title":"LA CHISMOSA","artist":"La Chismosa 2","album":null,"uri":"https://sp.dattavolt.com:8052/stream","trackType":""} Jul 17 13:40:37 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:37 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:37 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:37 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:37 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:37 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:37 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:37 volumio volumio[1724]: info: ------------------------------ 38ms Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::ClearQueue Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::stop Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:45 volumio volumio[1724]: verbose: UNSET VOLATILE Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::stPlaybackTimer Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::updateTrackBlock Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrackBlock Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::serviceStop Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::serviceStop Jul 17 13:40:45 volumio volumio[1724]: info: [1752759645059] ControllerWebradio::stop Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::clearPlayQueue Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::saveQueue Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::volumioPushQueue Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::addQueueItems Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::addQueueItems Jul 17 13:40:45 volumio volumio[1724]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99437338 Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::saveQueue Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::volumioPushQueue Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::updateTrackBlock Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrackBlock Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::volumioPlay Jul 17 13:40:45 volumio volumio[1724]: verbose: UNSET VOLATILE Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::play index 0 Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::stop Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:45 volumio volumio[1724]: verbose: UNSET VOLATILE Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::play index undefined Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::startPlaybackTimer Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: info: [1752759645077] ControllerWebradio::clearAddPlayTrack Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand stop took 42 milliseconds Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand stop took 25 milliseconds Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:45 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand status took 7 milliseconds Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand clear took 6 milliseconds Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand status took 5 milliseconds Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99437338" Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 17 13:40:45 volumio volumio[1724]: info: ------------------------------ 20ms Jul 17 13:40:45 volumio volumio[1724]: info: ------------------------------ 18ms Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:45 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:45 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:45 volumio volumio[1724]: error: updateQueue error: null Jul 17 13:40:45 volumio volumio[1724]: info: ------------------------------ 18ms Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:45 volumio volumio[1724]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 17 13:40:45 volumio volumio[1724]: info: ------------------------------ 26ms Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99437338" took 296 milliseconds Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand play Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:45 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:45 volumio volumio[1724]: info: ------------------------------ 285ms Jul 17 13:40:45 volumio volumio[1724]: info: ------------------------------ 284ms Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:45 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:45 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand play took 4 milliseconds Jul 17 13:40:45 volumio volumio[1724]: info: ------------------------------ 4ms Jul 17 13:40:45 volumio volumio[1724]: info: ------------------------------ 2ms Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:45 volumio volumio[1724]: info: Jul 17 13:40:45 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand status took 4 milliseconds Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 13:40:45 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:45 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 243/2000) Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Jul 17 13:40:45 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus stop Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 243/2000) Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Jul 17 13:40:45 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:45 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:45 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 243/2000) Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Jul 17 13:40:45 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:45 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:45 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:45 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:45 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: ------------------------------ 34ms Jul 17 13:40:46 volumio volumio[1724]: info: ------------------------------ 33ms Jul 17 13:40:46 volumio volumio[1724]: info: ------------------------------ 33ms Jul 17 13:40:46 volumio volumio[1724]: info: sendMpdCommand status took 30 milliseconds Jul 17 13:40:46 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 28 milliseconds Jul 17 13:40:46 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 27 milliseconds Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:46 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:46 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:46 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 243/2000) Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Jul 17 13:40:46 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:46 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:46 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:46 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 243/2000) Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Jul 17 13:40:46 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:46 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: ------------------------------ 55ms Jul 17 13:40:46 volumio volumio[1724]: info: ------------------------------ 53ms Jul 17 13:40:46 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 33 milliseconds Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:46 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:46 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:46 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 243/2000) Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Jul 17 13:40:46 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:46 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: ------------------------------ 75ms Jul 17 13:40:46 volumio volumio[1724]: info: Jul 17 13:40:46 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:46 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:46 volumio volumio[1724]: info: Jul 17 13:40:46 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:46 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:46 volumio volumio[1724]: info: Jul 17 13:40:46 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:46 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:46 volumio volumio[1724]: info: Jul 17 13:40:46 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:46 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:46 volumio volumio[1724]: info: Jul 17 13:40:46 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:46 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:46 volumio volumio[1724]: info: Jul 17 13:40:46 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:46 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:46 volumio volumio[1724]: info: ------------------------------ 5ms Jul 17 13:40:46 volumio volumio[1724]: info: sendMpdCommand status took 4 milliseconds Jul 17 13:40:46 volumio volumio[1724]: info: ------------------------------ 3ms Jul 17 13:40:46 volumio volumio[1724]: info: sendMpdCommand status took 3 milliseconds Jul 17 13:40:46 volumio volumio[1724]: info: ------------------------------ 3ms Jul 17 13:40:46 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:46 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 13:40:46 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 13:40:46 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:46 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:46 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:46 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:46 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":877,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Solardo & Darell Feat. Zion - Noche","artist":"Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Jul 17 13:40:46 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:46 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:46 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:46 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":877,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Solardo & Darell Feat. Zion - Noche","artist":"Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Jul 17 13:40:46 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:46 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:46 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:46 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":877,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Solardo & Darell Feat. Zion - Noche","artist":"Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Jul 17 13:40:46 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:46 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:46 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:46 volumio volumio[1724]: info: ------------------------------ 42ms Jul 17 13:40:46 volumio volumio[1724]: info: ------------------------------ 42ms Jul 17 13:40:46 volumio volumio[1724]: info: ------------------------------ 42ms Jul 17 13:40:48 volumio volumio[1724]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/(%231%20-%20243%2F2000)%20Dance%20UK%20Radio%20danceradiouk/1eac8b8e-62d6-4b8b-af76-8f578c6b23de.jpg' Jul 17 13:40:53 volumio volumio[1724]: info: Jul 17 13:40:53 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:53 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:53 volumio volumio[1724]: info: Jul 17 13:40:53 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:53 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:53 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:53 volumio volumio[1724]: info: Jul 17 13:40:53 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:53 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:53 volumio volumio[1724]: info: Jul 17 13:40:53 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:53 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:53 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:53 volumio volumio[1724]: info: Jul 17 13:40:53 volumio volumio[1724]: ---------------------------- MPD announces system playlist update Jul 17 13:40:53 volumio volumio[1724]: info: Ignoring MPD Status Update Jul 17 13:40:53 volumio volumio[1724]: info: Jul 17 13:40:53 volumio volumio[1724]: ---------------------------- MPD announces state update: player Jul 17 13:40:53 volumio volumio[1724]: info: ControllerMpd::getState Jul 17 13:40:53 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand status Jul 17 13:40:53 volumio volumio[1724]: info: ------------------------------ 5ms Jul 17 13:40:53 volumio volumio[1724]: info: sendMpdCommand status took 4 milliseconds Jul 17 13:40:53 volumio volumio[1724]: info: ------------------------------ 3ms Jul 17 13:40:53 volumio volumio[1724]: info: sendMpdCommand status took 3 milliseconds Jul 17 13:40:53 volumio volumio[1724]: info: ------------------------------ 2ms Jul 17 13:40:53 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:53 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:53 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:53 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:53 volumio volumio[1724]: info: sendMpdCommand status took 2 milliseconds Jul 17 13:40:53 volumio volumio[1724]: verbose: ControllerMpd::parseState Jul 17 13:40:53 volumio volumio[1724]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 13:40:53 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 17 13:40:53 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 17 13:40:53 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:53 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:53 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:53 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:53 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8185,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Maya & Pade Feat. Roxana - Fall","artist":"Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Jul 17 13:40:53 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:53 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:53 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:53 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:53 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:53 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:53 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:53 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:53 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8185,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Maya & Pade Feat. Roxana - Fall","artist":"Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Jul 17 13:40:53 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:53 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:53 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:53 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:53 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:53 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:53 volumio volumio[1724]: info: ------------------------------ 32ms Jul 17 13:40:53 volumio volumio[1724]: info: ------------------------------ 31ms Jul 17 13:40:53 volumio volumio[1724]: info: sendMpdCommand playlistinfo took 27 milliseconds Jul 17 13:40:53 volumio volumio[1724]: verbose: ControllerMpd::parseTrackInfo Jul 17 13:40:53 volumio volumio[1724]: info: ControllerMpd::pushState Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::servicePushState Jul 17 13:40:53 volumio volumio[1724]: info: CorePlayQueue::getTrack 0 Jul 17 13:40:53 volumio volumio[1724]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8185,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Edward Maya & Pade Feat. Roxana - Fall","artist":"Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Jul 17 13:40:53 volumio volumio[1724]: verbose: CURRENT POSITION 0 Jul 17 13:40:53 volumio volumio[1724]: info: CoreStateMachine::syncState stateService play Jul 17 13:40:53 volumio volumio[1724]: info: CoreStateMachine::syncState currentStatus play Jul 17 13:40:53 volumio volumio[1724]: info: Received an update from plugin. extracting info from payload Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 17 13:40:53 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:53 volumio volumio[1724]: info: CoreStateMachine::pushState Jul 17 13:40:53 volumio volumio[1724]: info: CoreCommandRouter::volumioPushState Jul 17 13:40:53 volumio volumio[1724]: info: ------------------------------ 43ms Jul 17 13:41:59 volumio volumio[1724]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 13:41:59 volumio volumio[1724]: Error: connect ETIMEDOUT 199.16.156.7:80 Jul 17 13:41:59 volumio volumio[1724]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 17 13:41:59 volumio volumio[1724]: errno: -110, Jul 17 13:41:59 volumio volumio[1724]: code: 'ETIMEDOUT', Jul 17 13:41:59 volumio volumio[1724]: syscall: 'connect', Jul 17 13:41:59 volumio volumio[1724]: address: '199.16.156.7', Jul 17 13:41:59 volumio volumio[1724]: port: 80 Jul 17 13:41:59 volumio volumio[1724]: } Jul 17 13:41:59 volumio volumio[1724]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 13:41:59 volumio sudo[2344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-17 13:40 Jul 17 13:41:59 volumio sudo[2344]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="1c5fa5a8788b087ca429be9d10851b25c5cc4f5b" VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9" VOLUMIO_FE3_VERSION="a86adf3c7ed2d6c50d9bca768f58ab2f56832dc1" VOLUMIO_BE_VERSION="c8882d89d3d4e0a1571e0dc9701741128f5a1656" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 31 Mar 2022 03:20:44 PM CEST" VOLUMIO_VERSION="3.251" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="e524350c1f6dfee48683e2ce9db25952"