-- Logs begin at Fri 2024-03-29 13:05:17 UTC, end at Fri 2024-03-29 13:28:01 UTC. -- Mar 29 13:27:00 volumio volumio[1018]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 29 13:27:00 volumio volumio[1018]: info: CoreStateMachine::ClearQueue Mar 29 13:27:00 volumio volumio[1018]: info: CoreStateMachine::stop Mar 29 13:27:00 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:00 volumio volumio[1018]: verbose: UNSET VOLATILE Mar 29 13:27:00 volumio volumio[1018]: info: CoreStateMachine::stPlaybackTimer Mar 29 13:27:00 volumio volumio[1018]: info: CoreStateMachine::updateTrackBlock Mar 29 13:27:01 volumio volumio[1018]: info: CorePlayQueue::getTrackBlock Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:01 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:01 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:01 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::serviceStop Mar 29 13:27:01 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:01 volumio volumio[1018]: info: CoreCommandRouter::serviceStop Mar 29 13:27:01 volumio volumio[1018]: info: ControllerMpd::stop Mar 29 13:27:01 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 13:27:01 volumio volumio[1018]: info: CorePlayQueue::clearPlayQueue Mar 29 13:27:01 volumio volumio[1018]: info: CorePlayQueue::saveQueue Mar 29 13:27:01 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:01 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:01 volumio volumio[1018]: info: CoreCommandRouter::volumioPushQueue Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::addQueueItems Mar 29 13:27:01 volumio volumio[1018]: info: CorePlayQueue::addQueueItems Mar 29 13:27:01 volumio volumio[1018]: info: Adding Item to queue: webrns/0 Mar 29 13:27:01 volumio volumio[1018]: info: Exploding uri webrns/0 in service rad357pl Mar 29 13:27:01 volumio volumio[1018]: info: [1711718821002] [rad357pl] explodeUri: webrns/0 Mar 29 13:27:01 volumio volumio[1018]: info: CorePlayQueue::saveQueue Mar 29 13:27:01 volumio volumio[1018]: info: CoreCommandRouter::volumioPushQueue Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::updateTrackBlock Mar 29 13:27:01 volumio volumio[1018]: info: CorePlayQueue::getTrackBlock Mar 29 13:27:01 volumio volumio[1018]: info: CoreCommandRouter::volumioPlay Mar 29 13:27:01 volumio volumio[1018]: verbose: UNSET VOLATILE Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::play index 0 Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::stop Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:01 volumio volumio[1018]: verbose: UNSET VOLATILE Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::play index undefined Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:01 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::startPlaybackTimer Mar 29 13:27:01 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:01 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 13:27:01 volumio volumio[1018]: info: Mar 29 13:27:01 volumio volumio[1018]: ---------------------------- MPD announces state update: player Mar 29 13:27:01 volumio volumio[1018]: info: sendMpdCommand stop took 85 milliseconds Mar 29 13:27:01 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:01 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:01 volumio volumio[1018]: info: sendMpdCommand stop took 78 milliseconds Mar 29 13:27:01 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:01 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:01 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:01 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:01 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:01 volumio volumio[1018]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rad357pl Received radio_paradise Mar 29 13:27:01 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand clear Mar 29 13:27:01 volumio volumio[1018]: info: Mar 29 13:27:01 volumio volumio[1018]: ---------------------------- MPD announces system playlist update Mar 29 13:27:01 volumio volumio[1018]: info: Ignoring MPD Status Update Mar 29 13:27:01 volumio volumio[1018]: info: sendMpdCommand status took 3 milliseconds Mar 29 13:27:01 volumio volumio[1018]: info: sendMpdCommand clear took 1 milliseconds Mar 29 13:27:01 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:01 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:01 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand add "http://stream.rcs.revma.com/ye5kghkgcm0uv" Mar 29 13:27:01 volumio volumio[1018]: error: updateQueue error: null Mar 29 13:27:01 volumio volumio[1018]: info: Mar 29 13:27:01 volumio volumio[1018]: ---------------------------- MPD announces system playlist update Mar 29 13:27:01 volumio volumio[1018]: info: Ignoring MPD Status Update Mar 29 13:27:01 volumio volumio[1018]: info: ------------------------------ 3ms Mar 29 13:27:01 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 13:27:01 volumio volumio[1018]: info: sendMpdCommand add "http://stream.rcs.revma.com/ye5kghkgcm0uv" took 2 milliseconds Mar 29 13:27:01 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:01 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand play Mar 29 13:27:01 volumio volumio[1018]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 29 13:27:01 volumio volumio[1018]: info: ------------------------------ 7ms Mar 29 13:27:01 volumio volumio[1018]: info: ------------------------------ 3ms Mar 29 13:27:01 volumio volumio[1018]: info: sendMpdCommand play took 1 milliseconds Mar 29 13:27:01 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 29 13:27:07 volumio volumio[1018]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::ClearQueue Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::stop Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:07 volumio volumio[1018]: verbose: UNSET VOLATILE Mar 29 13:27:07 volumio volumio[1018]: info: CorePlayQueue::clearPlayQueue Mar 29 13:27:07 volumio volumio[1018]: info: CorePlayQueue::saveQueue Mar 29 13:27:07 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:07 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:07 volumio volumio[1018]: info: CoreCommandRouter::volumioPushQueue Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::addQueueItems Mar 29 13:27:07 volumio volumio[1018]: info: CorePlayQueue::addQueueItems Mar 29 13:27:07 volumio volumio[1018]: info: Adding Item to queue: webrns/0 Mar 29 13:27:07 volumio volumio[1018]: info: Exploding uri webrns/0 in service rad357pl Mar 29 13:27:07 volumio volumio[1018]: info: [1711718827464] [rad357pl] explodeUri: webrns/0 Mar 29 13:27:07 volumio volumio[1018]: info: CorePlayQueue::saveQueue Mar 29 13:27:07 volumio volumio[1018]: info: CoreCommandRouter::volumioPushQueue Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::updateTrackBlock Mar 29 13:27:07 volumio volumio[1018]: info: CorePlayQueue::getTrackBlock Mar 29 13:27:07 volumio volumio[1018]: info: CoreCommandRouter::volumioPlay Mar 29 13:27:07 volumio volumio[1018]: verbose: UNSET VOLATILE Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::play index 0 Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::stop Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:07 volumio volumio[1018]: verbose: UNSET VOLATILE Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::play index undefined Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:07 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::startPlaybackTimer Mar 29 13:27:07 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:07 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 13:27:07 volumio volumio[1018]: info: Mar 29 13:27:07 volumio volumio[1018]: ---------------------------- MPD announces state update: player Mar 29 13:27:07 volumio volumio[1018]: info: sendMpdCommand stop took 3 milliseconds Mar 29 13:27:07 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:07 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:07 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand clear Mar 29 13:27:07 volumio volumio[1018]: info: Mar 29 13:27:07 volumio volumio[1018]: ---------------------------- MPD announces system playlist update Mar 29 13:27:07 volumio volumio[1018]: info: Ignoring MPD Status Update Mar 29 13:27:07 volumio volumio[1018]: info: sendMpdCommand status took 1 milliseconds Mar 29 13:27:07 volumio volumio[1018]: info: sendMpdCommand clear took 1 milliseconds Mar 29 13:27:07 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:07 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:07 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand add "http://stream.rcs.revma.com/ye5kghkgcm0uv" Mar 29 13:27:07 volumio volumio[1018]: error: updateQueue error: null Mar 29 13:27:07 volumio volumio[1018]: info: Mar 29 13:27:07 volumio volumio[1018]: ---------------------------- MPD announces system playlist update Mar 29 13:27:07 volumio volumio[1018]: info: Ignoring MPD Status Update Mar 29 13:27:07 volumio volumio[1018]: info: ------------------------------ 1ms Mar 29 13:27:07 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 29 13:27:07 volumio volumio[1018]: info: sendMpdCommand add "http://stream.rcs.revma.com/ye5kghkgcm0uv" took 1 milliseconds Mar 29 13:27:07 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:07 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand play Mar 29 13:27:07 volumio volumio[1018]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 29 13:27:07 volumio volumio[1018]: info: ------------------------------ 4ms Mar 29 13:27:07 volumio volumio[1018]: info: ------------------------------ 2ms Mar 29 13:27:07 volumio volumio[1018]: info: sendMpdCommand play took 0 milliseconds Mar 29 13:27:07 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 29 13:27:08 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:08 volumio volumio[1018]: info: Mar 29 13:27:08 volumio volumio[1018]: ---------------------------- MPD announces state update: update Mar 29 13:27:08 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:08 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:08 volumio volumio[1018]: info: sendMpdCommand status took 2 milliseconds Mar 29 13:27:08 volumio volumio[1018]: info: sendMpdCommand status took 2 milliseconds Mar 29 13:27:08 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:09 volumio volumio[1018]: info: Command Router : Notfying DB Updatetrue Mar 29 13:27:09 volumio volumio[1018]: info: CoreCommandRouter::Close All Modals sent Mar 29 13:27:09 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:09 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:09 volumio volumio[1018]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms. Mar 29 13:27:09 volumio volumio[1018]: info: MPD Database updated - AlbumList cache refreshed Mar 29 13:27:09 volumio volumio[1018]: info: Mar 29 13:27:09 volumio volumio[1018]: ---------------------------- MPD announces state update: database Mar 29 13:27:09 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:09 volumio volumio[1018]: info: Mar 29 13:27:09 volumio volumio[1018]: ---------------------------- MPD announces state update: update Mar 29 13:27:09 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:09 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:09 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:09 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:09 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 29 13:27:09 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:09 volumio volumio[1018]: info: ControllerMpd::pushState Mar 29 13:27:09 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:09 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:09 volumio volumio[1018]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ye5kghkgcm0uv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Mar 29 13:27:09 volumio volumio[1018]: verbose: CURRENT POSITION 0 Mar 29 13:27:09 volumio volumio[1018]: info: CoreStateMachine::syncState stateService play Mar 29 13:27:09 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus stop Mar 29 13:27:09 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:09 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:09 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:09 volumio volumio[1018]: info: ------------------------------ 484ms Mar 29 13:27:11 volumio volumio[1018]: Cannot compose Albumart path Mar 29 13:27:11 volumio volumio[1018]: info: sendMpdCommand status took 2106 milliseconds Mar 29 13:27:11 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:11 volumio volumio[1018]: info: Command Router : Notfying DB Updatefalse Mar 29 13:27:11 volumio volumio[1018]: info: CoreCommandRouter::Close All Modals sent Mar 29 13:27:11 volumio volumio[1018]: info: sendMpdCommand status took 2276 milliseconds Mar 29 13:27:11 volumio volumio[1018]: info: sendMpdCommand status took 2276 milliseconds Mar 29 13:27:11 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:11 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:11 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:11 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:11 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 29 13:27:11 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 29 13:27:11 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:11 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:11 volumio volumio[1018]: info: ControllerMpd::pushState Mar 29 13:27:11 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:11 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:11 volumio volumio[1018]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ye5kghkgcm0uv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Mar 29 13:27:11 volumio volumio[1018]: verbose: CURRENT POSITION 0 Mar 29 13:27:11 volumio volumio[1018]: info: CoreStateMachine::syncState stateService play Mar 29 13:27:11 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus play Mar 29 13:27:11 volumio volumio[1018]: info: Received an update from plugin. extracting info from payload Mar 29 13:27:11 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:11 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:11 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:11 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:11 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:11 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:11 volumio volumio[1018]: info: ControllerMpd::pushState Mar 29 13:27:11 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:11 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:11 volumio volumio[1018]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ye5kghkgcm0uv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Mar 29 13:27:11 volumio volumio[1018]: verbose: CURRENT POSITION 0 Mar 29 13:27:11 volumio volumio[1018]: info: CoreStateMachine::syncState stateService play Mar 29 13:27:11 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus play Mar 29 13:27:11 volumio volumio[1018]: info: Received an update from plugin. extracting info from payload Mar 29 13:27:11 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:11 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:11 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:11 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:11 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:11 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:11 volumio volumio[1018]: info: ------------------------------ 2285ms Mar 29 13:27:11 volumio volumio[1018]: info: ------------------------------ 2285ms Mar 29 13:27:12 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: podcast , handleBrowseUri Mar 29 13:27:16 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: podcast , handleBrowseUri Mar 29 13:27:17 volumio volumio[1018]: info: Mar 29 13:27:17 volumio volumio[1018]: ---------------------------- MPD announces state update: player Mar 29 13:27:17 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:17 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:17 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 29 13:27:17 volumio volumio[1018]: info: sendMpdCommand status took 2 milliseconds Mar 29 13:27:17 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:17 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:17 volumio volumio[1018]: info: sendMpdCommand clearerror took 1 milliseconds Mar 29 13:27:17 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 29 13:27:17 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:17 volumio volumio[1018]: info: ControllerMpd::pushState Mar 29 13:27:17 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:17 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:17 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:17 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:17 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:17 volumio volumio[1018]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ye5kghkgcm0uv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Mar 29 13:27:17 volumio volumio[1018]: verbose: CURRENT POSITION 0 Mar 29 13:27:17 volumio volumio[1018]: info: CoreStateMachine::syncState stateService stop Mar 29 13:27:17 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus play Mar 29 13:27:17 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:17 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:17 volumio volumio[1018]: info: CoreStateMachine::stPlaybackTimer Mar 29 13:27:17 volumio volumio[1018]: info: ------------------------------ 8ms Mar 29 13:27:19 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: podcast , handleBrowseUri Mar 29 13:27:21 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:21 volumio volumio[1018]: info: Mar 29 13:27:21 volumio volumio[1018]: ---------------------------- MPD announces state update: update Mar 29 13:27:21 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:21 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:21 volumio volumio[1018]: info: sendMpdCommand status took 2 milliseconds Mar 29 13:27:21 volumio volumio[1018]: info: sendMpdCommand status took 1 milliseconds Mar 29 13:27:21 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:22 volumio volumio[1018]: info: Command Router : Notfying DB Updatetrue Mar 29 13:27:22 volumio volumio[1018]: info: CoreCommandRouter::Close All Modals sent Mar 29 13:27:22 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:22 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:22 volumio volumio[1018]: info: MPD Database updated - AlbumList cache refreshed Mar 29 13:27:22 volumio volumio[1018]: info: Mar 29 13:27:22 volumio volumio[1018]: ---------------------------- MPD announces state update: database Mar 29 13:27:22 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:22 volumio volumio[1018]: info: Mar 29 13:27:22 volumio volumio[1018]: ---------------------------- MPD announces state update: update Mar 29 13:27:22 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:22 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:22 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:22 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:22 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 13:27:22 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:22 volumio volumio[1018]: info: ControllerMpd::pushState Mar 29 13:27:22 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:22 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:22 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:22 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:22 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:22 volumio volumio[1018]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ye5kghkgcm0uv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Mar 29 13:27:22 volumio volumio[1018]: verbose: CURRENT POSITION 0 Mar 29 13:27:22 volumio volumio[1018]: info: CoreStateMachine::syncState stateService stop Mar 29 13:27:22 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus stop Mar 29 13:27:22 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:22 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:22 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:22 volumio volumio[1018]: info: No code Mar 29 13:27:22 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:22 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:22 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:22 volumio volumio[1018]: info: ------------------------------ 484ms Mar 29 13:27:27 volumio volumio[1018]: Cannot compose Albumart path Mar 29 13:27:27 volumio volumio[1018]: info: sendMpdCommand status took 5381 milliseconds Mar 29 13:27:27 volumio volumio[1018]: info: sendMpdCommand status took 5381 milliseconds Mar 29 13:27:27 volumio volumio[1018]: info: sendMpdCommand status took 5381 milliseconds Mar 29 13:27:27 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:27 volumio volumio[1018]: info: Command Router : Notfying DB Updatefalse Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::Close All Modals sent Mar 29 13:27:27 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:27 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:27 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:27 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:27 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 29 13:27:27 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 29 13:27:27 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:27 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:27 volumio volumio[1018]: info: ControllerMpd::pushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:27 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:27 volumio volumio[1018]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ye5kghkgcm0uv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Mar 29 13:27:27 volumio volumio[1018]: verbose: CURRENT POSITION 0 Mar 29 13:27:27 volumio volumio[1018]: info: CoreStateMachine::syncState stateService stop Mar 29 13:27:27 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus stop Mar 29 13:27:27 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:27 volumio volumio[1018]: info: No code Mar 29 13:27:27 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:27 volumio volumio[1018]: info: ControllerMpd::pushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:27 volumio volumio[1018]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:27 volumio volumio[1018]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ye5kghkgcm0uv","artist":null,"album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Mar 29 13:27:27 volumio volumio[1018]: verbose: CURRENT POSITION 0 Mar 29 13:27:27 volumio volumio[1018]: info: CoreStateMachine::syncState stateService stop Mar 29 13:27:27 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus stop Mar 29 13:27:27 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:27 volumio volumio[1018]: info: No code Mar 29 13:27:27 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:27 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:27 volumio volumio[1018]: info: ------------------------------ 5688ms Mar 29 13:27:27 volumio volumio[1018]: info: ------------------------------ 5689ms Mar 29 13:27:30 volumio volumio[1018]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 29 13:27:30 volumio volumio[1018]: info: CoreStateMachine::ClearQueue Mar 29 13:27:30 volumio volumio[1018]: info: CoreStateMachine::stop Mar 29 13:27:30 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:30 volumio volumio[1018]: verbose: UNSET VOLATILE Mar 29 13:27:30 volumio volumio[1018]: info: CorePlayQueue::clearPlayQueue Mar 29 13:27:30 volumio volumio[1018]: info: CorePlayQueue::saveQueue Mar 29 13:27:30 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:30 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:30 volumio volumio[1018]: info: CoreCommandRouter::volumioPushQueue Mar 29 13:27:30 volumio volumio[1018]: info: CoreStateMachine::addQueueItems Mar 29 13:27:30 volumio volumio[1018]: info: CorePlayQueue::addQueueItems Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/0 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/0 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/1 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/1 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/2 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/2 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/3 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/3 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/4 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/4 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/5 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/5 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/6 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/6 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/7 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/7 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/8 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/8 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/9 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/9 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/10 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/10 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/11 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/11 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/12 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/12 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/13 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/13 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/14 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/14 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/15 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/15 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/16 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/16 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/17 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/17 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/18 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/18 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/19 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/19 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/20 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/20 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/21 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/21 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/22 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/22 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/23 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/23 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/24 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/24 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/25 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/25 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/26 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/26 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/27 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/27 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/28 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/28 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/29 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/29 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/30 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/30 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/31 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/31 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/32 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/32 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/33 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/33 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/34 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/34 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/35 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/35 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/36 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/36 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/37 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/37 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/38 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/38 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/39 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/39 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/40 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/40 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/41 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/41 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/42 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/42 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/43 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/43 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/44 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/44 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/45 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/45 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/46 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/46 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/47 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/47 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/48 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/48 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/49 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/49 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/50 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/50 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/51 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/51 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/52 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/52 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/53 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/53 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/54 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/54 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/55 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/55 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/56 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/56 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/57 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/57 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/58 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/58 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/59 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/59 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/60 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/60 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/61 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/61 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/62 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/62 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/63 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/63 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/64 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/64 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/65 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/65 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/66 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/66 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/67 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/67 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/68 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/68 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/69 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/69 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/70 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/70 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/71 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/71 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/72 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/72 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/73 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/73 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/74 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/74 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/75 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/75 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/76 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/76 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/77 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/77 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/78 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/78 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/79 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/79 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/80 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/80 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/81 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/81 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/82 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/82 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/83 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/83 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/84 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/84 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/85 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/85 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/86 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/86 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/87 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/87 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/88 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/88 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/89 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/89 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/90 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/90 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/91 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/91 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/92 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/92 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/93 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/93 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/94 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/94 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/95 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/95 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/96 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/96 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/97 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/97 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/98 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/98 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/99 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/99 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/100 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/100 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/101 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/101 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/102 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/102 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/103 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/103 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/104 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/104 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/105 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/105 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/106 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/106 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/107 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/107 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/108 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/108 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/109 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/109 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/110 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/110 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/111 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/111 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/112 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/112 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/113 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/113 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/114 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/114 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/115 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/115 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/116 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/116 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/117 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/117 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/118 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/118 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/119 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/119 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/120 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/120 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/121 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/121 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/122 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/122 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/123 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/123 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/124 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/124 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/125 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/125 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/126 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/126 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/127 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/127 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/128 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/128 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/129 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/129 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/130 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/130 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/131 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/131 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/132 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/132 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/133 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/133 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/134 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/134 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/135 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/135 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/136 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/136 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/137 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/137 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/138 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/138 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/139 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/139 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/140 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/140 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/141 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/141 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/142 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/142 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/143 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/143 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/144 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/144 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/145 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/145 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/146 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/146 in service podcast Mar 29 13:27:30 volumio volumio[1018]: info: Adding Item to queue: podcast/1/147 Mar 29 13:27:30 volumio volumio[1018]: info: Exploding uri podcast/1/147 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/148 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/148 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/149 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/149 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/150 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/150 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/151 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/151 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/152 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/152 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/153 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/153 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/154 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/154 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/155 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/155 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/156 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/156 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/157 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/157 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/158 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/158 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/159 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/159 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/160 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/160 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/161 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/161 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/162 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/162 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/163 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/163 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/164 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/164 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/165 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/165 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/166 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/166 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/167 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/167 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/168 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/168 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/169 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/169 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/170 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/170 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/171 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/171 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/172 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/172 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/173 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/173 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/174 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/174 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/175 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/175 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/176 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/176 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/177 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/177 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/178 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/178 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/179 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/179 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/180 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/180 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/181 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/181 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/182 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/182 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/183 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/183 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/184 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/184 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/185 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/185 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/186 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/186 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/187 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/187 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/188 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/188 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/189 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/189 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/190 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/190 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/191 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/191 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/192 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/192 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/193 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/193 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/194 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/194 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/195 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/195 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/196 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/196 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/197 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/197 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/198 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/198 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/199 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/199 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/200 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/200 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/201 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/201 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/202 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/202 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/203 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/203 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/204 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/204 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/205 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/205 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/206 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/206 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/207 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/207 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/208 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/208 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/209 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/209 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/210 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/210 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/211 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/211 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/212 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/212 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/213 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/213 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/214 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/214 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/215 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/215 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/216 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/216 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/217 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/217 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/218 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/218 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/219 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/219 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/220 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/220 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/221 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/221 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/222 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/222 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/223 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/223 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/224 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/224 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/225 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/225 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/226 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/226 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/227 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/227 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/228 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/228 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/229 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/229 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/230 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/230 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/231 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/231 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/232 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/232 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/233 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/233 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/234 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/234 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/235 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/235 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/236 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/236 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/237 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/237 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/238 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/238 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/239 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/239 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/240 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/240 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/241 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/241 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/242 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/242 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/243 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/243 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/244 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/244 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/245 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/245 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/246 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/246 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/247 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/247 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/248 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/248 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/249 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/249 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/250 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/250 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/251 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/251 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/252 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/252 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/253 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/253 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/254 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/254 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/255 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/255 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/256 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/256 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/257 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/257 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/258 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/258 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/259 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/259 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/260 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/260 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/261 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/261 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/262 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/262 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/263 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/263 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/264 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/264 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/265 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/265 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/266 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/266 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/267 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/267 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/268 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/268 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/269 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/269 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/270 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/270 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/271 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/271 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/272 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/272 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/273 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/273 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/274 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/274 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/275 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/275 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/276 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/276 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/277 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/277 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/278 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/278 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/279 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/279 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/280 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/280 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/281 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/281 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/282 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/282 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/283 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/283 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/284 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/284 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/285 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/285 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/286 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/286 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/287 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/287 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/288 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/288 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/289 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/289 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/290 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/290 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/291 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/291 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/292 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/292 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/293 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/293 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/294 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/294 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/295 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/295 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/296 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/296 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/297 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/297 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/298 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/298 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/299 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/299 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: Adding Item to queue: podcast/1/300 Mar 29 13:27:31 volumio volumio[1018]: info: Exploding uri podcast/1/300 in service podcast Mar 29 13:27:31 volumio volumio[1018]: info: CorePlayQueue::saveQueue Mar 29 13:27:31 volumio volumio[1018]: info: CoreCommandRouter::volumioPushQueue Mar 29 13:27:31 volumio volumio[1018]: info: CoreStateMachine::updateTrackBlock Mar 29 13:27:31 volumio volumio[1018]: info: CorePlayQueue::getTrackBlock Mar 29 13:27:31 volumio volumio[1018]: info: CoreCommandRouter::volumioPlay Mar 29 13:27:31 volumio volumio[1018]: verbose: UNSET VOLATILE Mar 29 13:27:31 volumio volumio[1018]: info: CoreStateMachine::play index 7 Mar 29 13:27:31 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:31 volumio volumio[1018]: info: CoreStateMachine::stop Mar 29 13:27:31 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:31 volumio volumio[1018]: verbose: UNSET VOLATILE Mar 29 13:27:31 volumio volumio[1018]: info: CoreStateMachine::play index undefined Mar 29 13:27:31 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:31 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:31 volumio volumio[1018]: info: CoreStateMachine::startPlaybackTimer Mar 29 13:27:31 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:31 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 13:27:31 volumio volumio[1018]: info: sendMpdCommand stop took 183 milliseconds Mar 29 13:27:31 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand clear Mar 29 13:27:31 volumio volumio[1018]: info: Mar 29 13:27:31 volumio volumio[1018]: ---------------------------- MPD announces system playlist update Mar 29 13:27:31 volumio volumio[1018]: info: Ignoring MPD Status Update Mar 29 13:27:31 volumio volumio[1018]: info: sendMpdCommand clear took 2 milliseconds Mar 29 13:27:31 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand add "https://dts.podtrac.com/redirect.mp3/chrt.fm/track/8DB4DB/pdst.fm/e/pfx.vpixl.com/6qj4J/nyt.simplecastaudio.com/03d8b493-87fc-4bd1-931f-8a8e9b945d8a/episodes/2200e751-c236-4970-8a16-0da68f2b402e/audio/128/default.mp3?aid=rss_feed&awCollectionId=03d8b493-87fc-4bd1-931f-8a8e9b945d8a&awEpisodeId=2200e751-c236-4970-8a16-0da68f2b402e&feed=54nAGcIl" Mar 29 13:27:31 volumio volumio[1018]: error: updateQueue error: null Mar 29 13:27:31 volumio volumio[1018]: info: Mar 29 13:27:31 volumio volumio[1018]: ---------------------------- MPD announces system playlist update Mar 29 13:27:31 volumio volumio[1018]: info: Ignoring MPD Status Update Mar 29 13:27:31 volumio volumio[1018]: info: ------------------------------ 7ms Mar 29 13:27:31 volumio volumio[1018]: info: sendMpdCommand add "https://dts.podtrac.com/redirect.mp3/chrt.fm/track/8DB4DB/pdst.fm/e/pfx.vpixl.com/6qj4J/nyt.simplecastaudio.com/03d8b493-87fc-4bd1-931f-8a8e9b945d8a/episodes/2200e751-c236-4970-8a16-0da68f2b402e/audio/128/default.mp3?aid=rss_feed&awCollectionId=03d8b493-87fc-4bd1-931f-8a8e9b945d8a&awEpisodeId=2200e751-c236-4970-8a16-0da68f2b402e&feed=54nAGcIl" took 5 milliseconds Mar 29 13:27:31 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand play Mar 29 13:27:31 volumio volumio[1018]: info: ------------------------------ 3ms Mar 29 13:27:31 volumio volumio[1018]: info: sendMpdCommand play took 2 milliseconds Mar 29 13:27:31 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:31 volumio volumio[1018]: info: sendMpdCommand status took 0 milliseconds Mar 29 13:27:31 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:31 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:31 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:31 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:31 volumio volumio[1018]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"uri":"https://dts.podtrac.com/redirect.mp3/chrt.fm/track/8DB4DB/pdst.fm/e/pfx.vpixl.com/6qj4J/nyt.simplecastaudio.com/03d8b493-87fc-4bd1-931f-8a8e9b945d8a/episodes/2200e751-c236-4970-8a16-0da68f2b402e/audio/128/default.mp3?aid=rss_feed&awCollectionId=03d8b493-87fc-4bd1-931f-8a8e9b945d8a&awEpisodeId=2200e751-c236-4970-8a16-0da68f2b402e&feed=54nAGcIl","trackType":"Podcast","serviceName":"podcast"} Mar 29 13:27:31 volumio volumio[1018]: verbose: CURRENT POSITION 7 Mar 29 13:27:31 volumio volumio[1018]: info: CoreStateMachine::syncState stateService play Mar 29 13:27:31 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus stop Mar 29 13:27:31 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:31 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:31 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:31 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:33 volumio volumio[1018]: info: Mar 29 13:27:33 volumio volumio[1018]: ---------------------------- MPD announces state update: update Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:33 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:33 volumio volumio[1018]: info: sendMpdCommand status took 4 milliseconds Mar 29 13:27:33 volumio volumio[1018]: info: sendMpdCommand status took 4 milliseconds Mar 29 13:27:33 volumio volumio[1018]: info: sendMpdCommand status took 3 milliseconds Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:33 volumio volumio[1018]: info: Command Router : Notfying DB Updatetrue Mar 29 13:27:33 volumio volumio[1018]: info: CoreCommandRouter::Close All Modals sent Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:33 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:33 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:33 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:33 volumio volumio[1018]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"uri":"https://dts.podtrac.com/redirect.mp3/chrt.fm/track/8DB4DB/pdst.fm/e/pfx.vpixl.com/6qj4J/nyt.simplecastaudio.com/03d8b493-87fc-4bd1-931f-8a8e9b945d8a/episodes/2200e751-c236-4970-8a16-0da68f2b402e/audio/128/default.mp3?aid=rss_feed&awCollectionId=03d8b493-87fc-4bd1-931f-8a8e9b945d8a&awEpisodeId=2200e751-c236-4970-8a16-0da68f2b402e&feed=54nAGcIl","trackType":"Podcast","serviceName":"podcast"} Mar 29 13:27:33 volumio volumio[1018]: verbose: CURRENT POSITION 7 Mar 29 13:27:33 volumio volumio[1018]: info: CoreStateMachine::syncState stateService play Mar 29 13:27:33 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus play Mar 29 13:27:33 volumio volumio[1018]: info: Received an update from plugin. extracting info from payload Mar 29 13:27:33 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:33 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:33 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:33 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:33 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:33 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:33 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:33 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:33 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 14 milliseconds Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:33 volumio volumio[1018]: info: ControllerMpd::pushState Mar 29 13:27:33 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:33 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:33 volumio volumio[1018]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current podcast Received mpd Mar 29 13:27:33 volumio volumio[1018]: info: ------------------------------ 287ms Mar 29 13:27:33 volumio volumio[1018]: info: MPD Database updated - AlbumList cache refreshed Mar 29 13:27:33 volumio volumio[1018]: info: Mar 29 13:27:33 volumio volumio[1018]: ---------------------------- MPD announces state update: database Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:33 volumio volumio[1018]: info: Mar 29 13:27:33 volumio volumio[1018]: ---------------------------- MPD announces state update: update Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:33 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:33 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:33 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:35 volumio volumio[1018]: Cannot compose Albumart path Mar 29 13:27:35 volumio volumio[1018]: info: Mar 29 13:27:35 volumio volumio[1018]: ---------------------------- MPD announces state update: player Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand status took 1728 milliseconds Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand status took 1728 milliseconds Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand status took 1728 milliseconds Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand status took 1728 milliseconds Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand status took 1727 milliseconds Mar 29 13:27:35 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:35 volumio volumio[1018]: info: Command Router : Notfying DB Updatefalse Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::Close All Modals sent Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"uri":"https://dts.podtrac.com/redirect.mp3/chrt.fm/track/8DB4DB/pdst.fm/e/pfx.vpixl.com/6qj4J/nyt.simplecastaudio.com/03d8b493-87fc-4bd1-931f-8a8e9b945d8a/episodes/2200e751-c236-4970-8a16-0da68f2b402e/audio/128/default.mp3?aid=rss_feed&awCollectionId=03d8b493-87fc-4bd1-931f-8a8e9b945d8a&awEpisodeId=2200e751-c236-4970-8a16-0da68f2b402e&feed=54nAGcIl","trackType":"Podcast","serviceName":"podcast"} Mar 29 13:27:35 volumio volumio[1018]: verbose: CURRENT POSITION 7 Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::syncState stateService play Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus play Mar 29 13:27:35 volumio volumio[1018]: info: Received an update from plugin. extracting info from payload Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"uri":"https://dts.podtrac.com/redirect.mp3/chrt.fm/track/8DB4DB/pdst.fm/e/pfx.vpixl.com/6qj4J/nyt.simplecastaudio.com/03d8b493-87fc-4bd1-931f-8a8e9b945d8a/episodes/2200e751-c236-4970-8a16-0da68f2b402e/audio/128/default.mp3?aid=rss_feed&awCollectionId=03d8b493-87fc-4bd1-931f-8a8e9b945d8a&awEpisodeId=2200e751-c236-4970-8a16-0da68f2b402e&feed=54nAGcIl","trackType":"Podcast","serviceName":"podcast"} Mar 29 13:27:35 volumio volumio[1018]: verbose: CURRENT POSITION 7 Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::syncState stateService play Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus play Mar 29 13:27:35 volumio volumio[1018]: info: Received an update from plugin. extracting info from payload Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:35 volumio volumio[1018]: info: Mar 29 13:27:35 volumio volumio[1018]: ---------------------------- MPD announces system playlist update Mar 29 13:27:35 volumio volumio[1018]: info: Ignoring MPD Status Update Mar 29 13:27:35 volumio volumio[1018]: info: Mar 29 13:27:35 volumio volumio[1018]: ---------------------------- MPD announces state update: player Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:35 volumio volumio[1018]: info: ControllerMpd::getState Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand status Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand status took 184 milliseconds Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand status took 183 milliseconds Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1613,"duration":1699,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"uri":"https://dts.podtrac.com/redirect.mp3/chrt.fm/track/8DB4DB/pdst.fm/e/pfx.vpixl.com/6qj4J/nyt.simplecastaudio.com/03d8b493-87fc-4bd1-931f-8a8e9b945d8a/episodes/2200e751-c236-4970-8a16-0da68f2b402e/audio/128/default.mp3?aid=rss_feed&awCollectionId=03d8b493-87fc-4bd1-931f-8a8e9b945d8a&awEpisodeId=2200e751-c236-4970-8a16-0da68f2b402e&feed=54nAGcIl","trackType":"Podcast","serviceName":"podcast"} Mar 29 13:27:35 volumio volumio[1018]: verbose: CURRENT POSITION 7 Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::syncState stateService play Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus play Mar 29 13:27:35 volumio volumio[1018]: info: Received an update from plugin. extracting info from payload Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:35 volumio volumio[1018]: info: ControllerMpd::pushState Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current podcast Received mpd Mar 29 13:27:35 volumio volumio[1018]: info: ControllerMpd::pushState Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current podcast Received mpd Mar 29 13:27:35 volumio volumio[1018]: info: ------------------------------ 1919ms Mar 29 13:27:35 volumio volumio[1018]: info: ------------------------------ 1919ms Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand status took 12 milliseconds Mar 29 13:27:35 volumio volumio[1018]: info: ------------------------------ 13ms Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand status took 12 milliseconds Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 11 milliseconds Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseState Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1857,"duration":1699,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"uri":"https://dts.podtrac.com/redirect.mp3/chrt.fm/track/8DB4DB/pdst.fm/e/pfx.vpixl.com/6qj4J/nyt.simplecastaudio.com/03d8b493-87fc-4bd1-931f-8a8e9b945d8a/episodes/2200e751-c236-4970-8a16-0da68f2b402e/audio/128/default.mp3?aid=rss_feed&awCollectionId=03d8b493-87fc-4bd1-931f-8a8e9b945d8a&awEpisodeId=2200e751-c236-4970-8a16-0da68f2b402e&feed=54nAGcIl","trackType":"Podcast","serviceName":"podcast"} Mar 29 13:27:35 volumio volumio[1018]: verbose: CURRENT POSITION 7 Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::syncState stateService play Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::syncState currentStatus play Mar 29 13:27:35 volumio volumio[1018]: info: Received an update from plugin. extracting info from payload Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:35 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:35 volumio volumio[1018]: info: ControllerMpd::pushState Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current podcast Received mpd Mar 29 13:27:35 volumio volumio[1018]: info: ------------------------------ 202ms Mar 29 13:27:35 volumio volumio[1018]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 29 13:27:35 volumio volumio[1018]: verbose: ControllerMpd::parseTrackInfo Mar 29 13:27:35 volumio volumio[1018]: info: ControllerMpd::pushState Mar 29 13:27:35 volumio volumio[1018]: info: CoreCommandRouter::servicePushState Mar 29 13:27:35 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:35 volumio volumio[1018]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current podcast Received mpd Mar 29 13:27:35 volumio volumio[1018]: info: ------------------------------ 19ms Mar 29 13:27:39 volumio volumio[1018]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms. Mar 29 13:27:46 volumio volumio[1018]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 29 13:27:46 volumio volumio[1018]: info: CoreStateMachine::ClearQueue Mar 29 13:27:46 volumio volumio[1018]: info: CoreStateMachine::stop Mar 29 13:27:46 volumio volumio[1018]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:27:46 volumio volumio[1018]: verbose: UNSET VOLATILE Mar 29 13:27:46 volumio volumio[1018]: info: CoreStateMachine::stPlaybackTimer Mar 29 13:27:46 volumio volumio[1018]: info: CoreStateMachine::updateTrackBlock Mar 29 13:27:46 volumio volumio[1018]: info: CorePlayQueue::getTrackBlock Mar 29 13:27:46 volumio volumio[1018]: info: CoreStateMachine::pushState Mar 29 13:27:46 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:46 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:46 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:46 volumio volumio[1018]: info: CoreStateMachine::serviceStop Mar 29 13:27:46 volumio volumio[1018]: info: CorePlayQueue::getTrack 7 Mar 29 13:27:46 volumio volumio[1018]: info: CoreCommandRouter::serviceStop Mar 29 13:27:46 volumio volumio[1018]: info: ControllerMpd::stop Mar 29 13:27:46 volumio volumio[1018]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 13:27:46 volumio volumio[1018]: info: CorePlayQueue::clearPlayQueue Mar 29 13:27:46 volumio volumio[1018]: info: CorePlayQueue::saveQueue Mar 29 13:27:46 volumio volumio[1018]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:46 volumio volumio[1018]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:46 volumio volumio[1018]: info: CoreCommandRouter::volumioPushQueue Mar 29 13:27:46 volumio volumio[1018]: info: CoreStateMachine::addQueueItems Mar 29 13:27:46 volumio volumio[1018]: info: CorePlayQueue::addQueueItems Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/0 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/0 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/1 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/1 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/2 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/2 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/3 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/3 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/4 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/4 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/5 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/5 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/6 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/6 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/7 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/7 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/8 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/8 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/9 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/9 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/10 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/10 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/11 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/11 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/12 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/12 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/13 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/13 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/14 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/14 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/15 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/15 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/16 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/16 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/17 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/17 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/18 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/18 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/19 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/19 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/20 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/20 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/21 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/21 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/22 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/22 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/23 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/23 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/24 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/24 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/25 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/25 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/26 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/26 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/27 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/27 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/28 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/28 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/29 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/29 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/30 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/30 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/31 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/31 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/32 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/32 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/33 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/33 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/34 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/34 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/35 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/35 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/36 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/36 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/37 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/37 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/38 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/38 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/39 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/39 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/40 Mar 29 13:27:46 volumio volumio[1018]: info: Exploding uri podcast/1/40 in service podcast Mar 29 13:27:46 volumio volumio[1018]: info: Adding Item to queue: podcast/1/41 Mar 29 13:27:51 volumio volumio-remote-updater[677]: [2024-03-29 13:27:51] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 29 13:27:51 volumio volumio-remote-updater[677]: [2024-03-29 13:27:51] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 29 13:27:51 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Mar 29 13:27:51 volumio systemd[1]: Unit volumio.service entered failed state. Mar 29 13:27:51 volumio systemd[1]: Starting dynamicswap service... Mar 29 13:27:51 volumio systemd[1]: Started dynamicswap service. Mar 29 13:27:51 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Mar 29 13:27:51 volumio systemd[1]: Starting dynamicswap service... Mar 29 13:27:51 volumio systemd[1]: Started dynamicswap service. Mar 29 13:27:51 volumio systemd[1]: Stopping Volumio Backend Module... Mar 29 13:27:51 volumio systemd[1]: Starting Volumio Backend Module... Mar 29 13:27:51 volumio systemd[1]: Started Volumio Backend Module. Mar 29 13:27:54 volumio node[3970]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 29 13:27:54 volumio node[3970]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 29 13:27:54 volumio node[3970]: *** WARNING *** For more information see Mar 29 13:27:54 volumio node[3970]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 29 13:27:54 volumio node[3970]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 29 13:27:54 volumio node[3970]: *** WARNING *** For more information see Mar 29 13:27:56 volumio volumio-remote-updater[677]: [2024-03-29 13:27:56] [connect] Successful connection Mar 29 13:27:57 volumio systemd-journal[268]: Suppressed 753 messages from /system.slice/volumio.service Mar 29 13:27:57 volumio volumio[3970]: info: ControllerPodcast::constructor Mar 29 13:27:58 volumio volumio[3970]: info: Loading plugin "rad357pl"... Mar 29 13:27:58 volumio volumio[3970]: info: Applying required configuration parameters for plugin rad357pl Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878203] [rad357pl] API delay: 5 Mar 29 13:27:58 volumio volumio[3970]: info: Loading plugin "radio_paradise"... Mar 29 13:27:58 volumio volumio[3970]: info: Applying required configuration parameters for plugin radio_paradise Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878424] [RadioParadise] API delay: 5 Mar 29 13:27:58 volumio volumio[3970]: info: Loading plugin "swarmstation"... Mar 29 13:27:58 volumio volumio[3970]: info: Applying required configuration parameters for plugin swarmstation Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878581] [Swarmstation] API delay: 5 Mar 29 13:27:58 volumio volumio[3970]: info: ___________ START PLUGINS ___________ Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878590] CoreMusicLibrary::Adding element Media Servers Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:27:58 volumio volumio[3970]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 29 13:27:58 volumio volumio[3970]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878638] CoreMusicLibrary::Adding element Last_100 Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878640] CoreMusicLibrary::Adding element Webradio Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878649] CoreMusicLibrary::Adding element Bandcamp Discover Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:27:58 volumio volumio[3970]: Begin ConnectionManager constructor Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878655] CoreMusicLibrary::Adding element Jellyfin Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:27:58 volumio volumio[3970]: info: [jellyfin-poller-worker] start(): Started polling... Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878666] CoreMusicLibrary::Adding element Pandora Radio Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878667] ControllerPandora::validateLoginCredentials Mar 29 13:27:58 volumio volumio[3970]: error: [1711718878667] [Pandora] Need email address and password. See plugin settings. Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 13:27:58 volumio sudo[4065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Mar 29 13:27:58 volumio sudo[4065]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878669] CoreMusicLibrary::Adding element Personal Radio Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:27:58 volumio sudo[4065]: pam_unix(sudo:session): session closed for user root Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878696] CoreMusicLibrary::Adding element Podcast Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878707] CoreMusicLibrary::Adding element RADIO 357 Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878709] CoreMusicLibrary::Adding element Radio Paradise Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 13:27:58 volumio volumio[3970]: info: [1711718878711] CoreMusicLibrary::Adding element SWARM Station Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:27:58 volumio volumio[3970]: info: ------------------------------------------- Mar 29 13:27:58 volumio volumio[3970]: info: ----- MyVolumio plugins startup ---- Mar 29 13:27:58 volumio volumio[3970]: info: ------------------------------------------- Mar 29 13:27:58 volumio volumio[3970]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 29 13:27:58 volumio volumio[3970]: info: Loading i18n strings for locale ru Mar 29 13:27:58 volumio volumio[3970]: Updating browse sources language Mar 29 13:27:58 volumio volumio[3970]: Cannot find translation for sourceMedia Servers Mar 29 13:27:58 volumio volumio[3970]: Cannot find translation for sourceBandcamp Discover Mar 29 13:27:58 volumio volumio[3970]: Cannot find translation for sourceJellyfin Mar 29 13:27:58 volumio volumio[3970]: Cannot find translation for sourcePandora Radio Mar 29 13:27:58 volumio volumio[3970]: Cannot find translation for sourcePersonal Radio Mar 29 13:27:58 volumio volumio[3970]: Cannot find translation for sourcePodcast Mar 29 13:27:58 volumio volumio[3970]: Cannot find translation for sourceRADIO 357 Mar 29 13:27:58 volumio volumio[3970]: Cannot find translation for sourceRadio Paradise Mar 29 13:27:58 volumio volumio[3970]: Cannot find translation for sourceSWARM Station Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::initPlayerControls Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 13:27:58 volumio volumio[3970]: info: BOOT COMPLETED Mar 29 13:27:58 volumio volumio[3970]: [Metrics] CommandRouter: 6s 741.81ms Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 13:27:58 volumio volumio[3970]: aplay: main:722: audio open error: Device or resource busy Mar 29 13:27:58 volumio volumio[3970]: Cannot play startup sound Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::Close All Modals sent Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::Close All Modals sent Mar 29 13:27:58 volumio volumio[3970]: Express server listening on port 3000 Mar 29 13:27:58 volumio volumio[3970]: [Metrics] WebUI: 6s 927.57ms Mar 29 13:27:58 volumio volumio[3970]: info: Setting Device type: x86 Mar 29 13:27:58 volumio volumio[3970]: Volumio Calling Home Mar 29 13:27:58 volumio volumio[3970]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms. Mar 29 13:27:58 volumio volumio[3970]: info: CoreStateMachine::resetVolumioState Mar 29 13:27:58 volumio volumio[3970]: info: CoreStateMachine::getcurrentVolume Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioRetrievevolume Mar 29 13:27:58 volumio volumio[3970]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Mar 29 13:27:58 volumio volumio[3970]: error: Cannot start Roon Bridge Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service Mar 29 13:27:58 volumio volumio[3970]: Failed to start roonbridge.service: Unit roonbridge.service failed to load: No such file or directory. Mar 29 13:27:58 volumio volumio[3970]: info: MPD running with PID712 Mar 29 13:27:58 volumio volumio[3970]: ,establishing connection Mar 29 13:27:58 volumio sudo[4077]: pam_unix(sudo:auth): conversation failed Mar 29 13:27:58 volumio sudo[4077]: pam_unix(sudo:auth): auth could not identify password for [volumio] Mar 29 13:27:58 volumio volumio[3970]: info: Cannot mount NAS Musik at system boot, trial number 2 ,retrying in 5 seconds Mar 29 13:27:58 volumio volumio-remote-updater[677]: [2024-03-29 13:27:58] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1711718876 101 Mar 29 13:27:58 volumio volumio[3970]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Mar 29 13:27:58 volumio volumio[3970]: sudo: no tty present and no askpass program specified Mar 29 13:27:58 volumio volumio[3970]: info: VolumeController:: Volume=89 Mute =false Mar 29 13:27:58 volumio volumio[3970]: info: CoreStateMachine::pushState Mar 29 13:27:58 volumio volumio[3970]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:58 volumio volumio[3970]: info: CoreStateMachine::updateTrackBlock Mar 29 13:27:58 volumio volumio[3970]: info: CorePlayQueue::getTrackBlock Mar 29 13:27:58 volumio volumio[3970]: info: CoreCommandRouter::volumioRetrievevolume Mar 29 13:27:58 volumio volumio[3970]: info: Volumio called home Mar 29 13:27:58 volumio volumio[3970]: info: Reloading queue from file Mar 29 13:27:59 volumio volumio[3970]: info: CoreStateMachine::setRepeat null single undefined Mar 29 13:27:59 volumio volumio[3970]: info: CoreStateMachine::pushState Mar 29 13:27:59 volumio volumio[3970]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:59 volumio volumio[3970]: info: CoreStateMachine::setRandom null Mar 29 13:27:59 volumio volumio[3970]: info: CoreStateMachine::pushState Mar 29 13:27:59 volumio volumio[3970]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:59 volumio volumio[3970]: info: VolumeController:: Volume=89 Mute =false Mar 29 13:27:59 volumio volumio[3970]: info: CoreStateMachine::pushState Mar 29 13:27:59 volumio volumio[3970]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::volumioPushState Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:27:59 volumio volumio[3970]: info: Starting Shairport Sync Mar 29 13:27:59 volumio volumio[3970]: info: Starting Shairport Sync Mar 29 13:27:59 volumio sudo[4083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 29 13:27:59 volumio sudo[4083]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 13:27:59 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 29 13:27:59 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 29 13:27:59 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 29 13:27:59 volumio sudo[4086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 29 13:27:59 volumio sudo[4086]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 13:27:59 volumio sudo[4083]: pam_unix(sudo:session): session closed for user root Mar 29 13:27:59 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 29 13:27:59 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 29 13:27:59 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 29 13:27:59 volumio sudo[4086]: pam_unix(sudo:session): session closed for user root Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 13:27:59 volumio volumio[3970]: Discovery: adding 34d75b7d-54ef-4869-9014-709d8968259b Mar 29 13:27:59 volumio volumio[3970]: info: mDNS: Found device Volumio Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::volumioGetState Mar 29 13:27:59 volumio volumio[3970]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:59 volumio volumio[3970]: info: Shairport-Sync Started Mar 29 13:27:59 volumio volumio[3970]: Error adding Membership: Error: addMembership EINVAL Mar 29 13:27:59 volumio volumio[3970]: info: Shairport-Sync Started Mar 29 13:27:59 volumio volumio[3970]: Discovery: this is already registered, 34d75b7d-54ef-4869-9014-709d8968259b Mar 29 13:27:59 volumio volumio[3970]: info: mDNS: Found device Volumio Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::volumioGetState Mar 29 13:27:59 volumio volumio[3970]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::volumioGetState Mar 29 13:27:59 volumio volumio[3970]: info: CorePlayQueue::getTrack 0 Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 29 13:27:59 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 29 13:28:00 volumio volumio[3970]: Cannot compose Albumart path Mar 29 13:28:01 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 29 13:28:01 volumio volumio[3970]: info: Listing playlists Mar 29 13:28:01 volumio volumio[3970]: info: CoreCommandRouter::volumioGetVisibleSources Mar 29 13:28:01 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 13:28:01 volumio volumio[3970]: info: CoreCommandRouter::volumioGetQueue Mar 29 13:28:01 volumio volumio[3970]: info: CoreStateMachine::getQueue Mar 29 13:28:01 volumio volumio[3970]: info: CorePlayQueue::getQueue Mar 29 13:28:01 volumio volumio[3970]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 29 13:28:01 volumio volumio[3970]: info: CoreStateMachine::ClearQueue Mar 29 13:28:01 volumio volumio[3970]: info: CoreStateMachine::stop Mar 29 13:28:01 volumio volumio[3970]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 13:28:01 volumio volumio[3970]: verbose: UNSET VOLATILE Mar 29 13:28:01 volumio volumio[3970]: info: CorePlayQueue::clearPlayQueue Mar 29 13:28:01 volumio volumio[3970]: info: CorePlayQueue::saveQueue Mar 29 13:28:01 volumio volumio[3970]: info: CoreCommandRouter::volumioPushState Mar 29 13:28:01 volumio volumio[3970]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 13:28:01 volumio volumio[3970]: info: CoreCommandRouter::volumioPushQueue Mar 29 13:28:01 volumio volumio[3970]: info: CoreStateMachine::addQueueItems Mar 29 13:28:01 volumio volumio[3970]: info: CorePlayQueue::addQueueItems Mar 29 13:28:01 volumio volumio[3970]: info: Adding Item to queue: podcast/1/0 Mar 29 13:28:01 volumio volumio[3970]: info: Exploding uri podcast/1/0 in service podcast Mar 29 13:28:01 volumio volumio[3970]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 13:28:01 volumio volumio[3970]: TypeError: Cannot read property 'url' of undefined Mar 29 13:28:01 volumio volumio[3970]: at ControllerPodcast.explodeUri (/data/plugins/music_service/podcast/index.js:665:22) Mar 29 13:28:01 volumio volumio[3970]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1283:16) Mar 29 13:28:01 volumio volumio[3970]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:144:48) Mar 29 13:28:01 volumio volumio[3970]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:238:25) Mar 29 13:28:01 volumio volumio[3970]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:476:23) Mar 29 13:28:01 volumio volumio[3970]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:452:17) Mar 29 13:28:01 volumio volumio[3970]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:106:35) Mar 29 13:28:01 volumio volumio[3970]: at emitTwo (events.js:126:13) Mar 29 13:28:01 volumio volumio[3970]: at Socket.emit (events.js:214:7) Mar 29 13:28:01 volumio volumio[3970]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Mar 29 13:28:01 volumio volumio[3970]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Mar 29 13:28:01 volumio volumio[3970]: at process._tickCallback (internal/process/next_tick.js:180:9) Mar 29 13:28:01 volumio volumio[3970]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 13:28:01 volumio sudo[4114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-29 13:27 Mar 29 13:28:01 volumio sudo[4114]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"