-- Logs begin at Mon 2025-12-15 08:05:08 UTC, end at Mon 2025-12-15 10:48:53 UTC. -- Dec 15 10:47:03 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:03 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:47:03 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:03 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:03 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:03 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:03 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::play index 1 Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:03 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:03 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:03 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:03 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:03 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:03 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 1 Dec 15 10:47:06 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:06 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:47:06 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:06 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:06 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:06 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:06 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:06 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:06 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:06 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:06 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:06 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:06 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::play index 2 Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:06 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:06 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:06 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:06 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:06 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:06 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:06 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:06 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:06 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:06 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 2 Dec 15 10:47:10 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:10 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:10 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$63797 Dec 15 10:47:10 volumio-viki volumio[1223]: info: Exploding uri upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$63797 in service upnp_browser Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::play index 0 Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::startPlaybackTimer Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:10 volumio-viki volumio[1223]: info: [1765795630422] ControllerUPNPBrowser::clearAddPlayTrack Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand stop Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand stop took 1 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand clear Dec 15 10:47:10 volumio-viki volumio[1223]: info: Dec 15 10:47:10 volumio-viki volumio[1223]: ---------------------------- MPD announces system playlist update Dec 15 10:47:10 volumio-viki volumio[1223]: info: Ignoring MPD Status Update Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand clear took 0 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.88.26:50002/m/NDLNA/288427.wav" Dec 15 10:47:10 volumio-viki volumio[1223]: info: Dec 15 10:47:10 volumio-viki volumio[1223]: ---------------------------- MPD announces system playlist update Dec 15 10:47:10 volumio-viki volumio[1223]: info: Ignoring MPD Status Update Dec 15 10:47:10 volumio-viki volumio[1223]: info: Dec 15 10:47:10 volumio-viki volumio[1223]: ---------------------------- MPD announces system playlist update Dec 15 10:47:10 volumio-viki volumio[1223]: info: Ignoring MPD Status Update Dec 15 10:47:10 volumio-viki volumio[1223]: error: updateQueue error: null Dec 15 10:47:10 volumio-viki volumio[1223]: info: ------------------------------ 2ms Dec 15 10:47:10 volumio-viki volumio[1223]: error: updateQueue error: null Dec 15 10:47:10 volumio-viki volumio[1223]: error: updateQueue error: null Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.88.26:50002/m/NDLNA/288427.wav" Dec 15 10:47:10 volumio-viki volumio[1223]: info: ------------------------------ 34ms Dec 15 10:47:10 volumio-viki volumio[1223]: info: ------------------------------ 33ms Dec 15 10:47:10 volumio-viki volumio[1223]: info: Dec 15 10:47:10 volumio-viki volumio[1223]: ---------------------------- MPD announces system playlist update Dec 15 10:47:10 volumio-viki volumio[1223]: info: Ignoring MPD Status Update Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand add "http://192.168.88.26:50002/m/NDLNA/288427.wav" took 1 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand play Dec 15 10:47:10 volumio-viki volumio[1223]: info: Dec 15 10:47:10 volumio-viki volumio[1223]: ---------------------------- MPD announces system playlist update Dec 15 10:47:10 volumio-viki volumio[1223]: info: Ignoring MPD Status Update Dec 15 10:47:10 volumio-viki volumio[1223]: info: Dec 15 10:47:10 volumio-viki volumio[1223]: ---------------------------- MPD announces system playlist update Dec 15 10:47:10 volumio-viki volumio[1223]: info: Ignoring MPD Status Update Dec 15 10:47:10 volumio-viki volumio[1223]: info: ------------------------------ 3ms Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand play took 2 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: info: ------------------------------ 1ms Dec 15 10:47:10 volumio-viki volumio[1223]: info: ------------------------------ 1ms Dec 15 10:47:10 volumio-viki volumio[1223]: info: Dec 15 10:47:10 volumio-viki volumio[1223]: ---------------------------- MPD announces state update: player Dec 15 10:47:10 volumio-viki volumio[1223]: info: ControllerMpd::getState Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Dec 15 10:47:10 volumio-viki volumio[1223]: info: Dec 15 10:47:10 volumio-viki volumio[1223]: ---------------------------- MPD announces state update: player Dec 15 10:47:10 volumio-viki volumio[1223]: info: ControllerMpd::getState Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Dec 15 10:47:10 volumio-viki volumio[1223]: info: Dec 15 10:47:10 volumio-viki volumio[1223]: ---------------------------- MPD announces state update: player Dec 15 10:47:10 volumio-viki volumio[1223]: info: ControllerMpd::getState Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand status took 15 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::parseState Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 10:47:10 volumio-viki volumio[1223]: info: Dec 15 10:47:10 volumio-viki volumio[1223]: ---------------------------- MPD announces state update: player Dec 15 10:47:10 volumio-viki volumio[1223]: info: ControllerMpd::getState Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Dec 15 10:47:10 volumio-viki volumio[1223]: info: Dec 15 10:47:10 volumio-viki volumio[1223]: ---------------------------- MPD announces state update: player Dec 15 10:47:10 volumio-viki volumio[1223]: info: ControllerMpd::getState Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Dec 15 10:47:10 volumio-viki volumio[1223]: info: Dec 15 10:47:10 volumio-viki volumio[1223]: ---------------------------- MPD announces state update: player Dec 15 10:47:10 volumio-viki volumio[1223]: info: ControllerMpd::getState Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand status took 17 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand status took 16 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand status took 2 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::parseState Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::parseState Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::parseTrackInfo Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::parseState Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 10:47:10 volumio-viki volumio[1223]: info: ControllerMpd::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::servicePushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"352.8 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"288427.wav","artist":null,"album":null,"uri":"http://192.168.88.26:50002/m/NDLNA/288427.wav","trackType":"wav"} Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: CURRENT POSITION 0 Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::syncState stateService play Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::syncState currentStatus stop Dec 15 10:47:10 volumio-viki volumio[1223]: info: ------------------------------ 23ms Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand status took 6 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand status took 5 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::parseState Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::parseState Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::parseTrackInfo Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::parseTrackInfo Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::parseTrackInfo Dec 15 10:47:10 volumio-viki volumio[1223]: info: ControllerMpd::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::servicePushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"352.8 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"288427.wav","artist":null,"album":null,"uri":"http://192.168.88.26:50002/m/NDLNA/288427.wav","trackType":"wav"} Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: CURRENT POSITION 0 Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::syncState stateService play Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::syncState currentStatus play Dec 15 10:47:10 volumio-viki volumio[1223]: info: Received an update from plugin. extracting info from payload Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: ControllerMpd::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::servicePushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"352.8 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"288427.wav","artist":null,"album":null,"uri":"http://192.168.88.26:50002/m/NDLNA/288427.wav","trackType":"wav"} Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: CURRENT POSITION 0 Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::syncState stateService play Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::syncState currentStatus play Dec 15 10:47:10 volumio-viki volumio[1223]: info: Received an update from plugin. extracting info from payload Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: ControllerMpd::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::servicePushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"352.8 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"288427.wav","artist":null,"album":null,"uri":"http://192.168.88.26:50002/m/NDLNA/288427.wav","trackType":"wav"} Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: CURRENT POSITION 0 Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::syncState stateService play Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::syncState currentStatus play Dec 15 10:47:10 volumio-viki volumio[1223]: info: Received an update from plugin. extracting info from payload Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: ------------------------------ 54ms Dec 15 10:47:10 volumio-viki volumio[1223]: info: ------------------------------ 53ms Dec 15 10:47:10 volumio-viki volumio[1223]: info: ------------------------------ 39ms Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand playlistinfo took 29 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: info: sendMpdCommand playlistinfo took 28 milliseconds Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: ControllerMpd::parseTrackInfo Dec 15 10:47:10 volumio-viki volumio[1223]: info: ControllerMpd::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::servicePushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":202,"samplerate":"352.8 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"288427.wav","artist":null,"album":null,"uri":"http://192.168.88.26:50002/m/NDLNA/288427.wav","trackType":"wav"} Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: CURRENT POSITION 0 Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::syncState stateService play Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::syncState currentStatus play Dec 15 10:47:10 volumio-viki volumio[1223]: info: Received an update from plugin. extracting info from payload Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: ControllerMpd::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::servicePushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17,"duration":202,"samplerate":"352.8 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"288427.wav","artist":null,"album":null,"uri":"http://192.168.88.26:50002/m/NDLNA/288427.wav","trackType":"wav"} Dec 15 10:47:10 volumio-viki volumio[1223]: verbose: CURRENT POSITION 0 Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::syncState stateService play Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::syncState currentStatus play Dec 15 10:47:10 volumio-viki volumio[1223]: info: Received an update from plugin. extracting info from payload Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:10 volumio-viki volumio[1223]: info: ------------------------------ 75ms Dec 15 10:47:10 volumio-viki volumio[1223]: info: ------------------------------ 84ms Dec 15 10:47:20 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::stPlaybackTimer Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::serviceStop Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::serviceStop Dec 15 10:47:20 volumio-viki volumio[1223]: info: [1765795640061] ControllerUPNPBrowser::stop Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand stop Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:20 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:20 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:20 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::play index 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:20 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:20 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:20 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:20 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:20 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:20 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:20 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:20 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:20 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: Dec 15 10:47:20 volumio-viki volumio[1223]: ---------------------------- MPD announces state update: player Dec 15 10:47:20 volumio-viki volumio[1223]: info: sendMpdCommand stop took 12 milliseconds Dec 15 10:47:20 volumio-viki volumio[1223]: info: ControllerMpd::getState Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Dec 15 10:47:20 volumio-viki volumio[1223]: info: Dec 15 10:47:20 volumio-viki volumio[1223]: ---------------------------- MPD announces state update: player Dec 15 10:47:20 volumio-viki volumio[1223]: info: ControllerMpd::getState Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Dec 15 10:47:20 volumio-viki volumio[1223]: info: Dec 15 10:47:20 volumio-viki volumio[1223]: ---------------------------- MPD announces state update: player Dec 15 10:47:20 volumio-viki volumio[1223]: info: ControllerMpd::getState Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand status Dec 15 10:47:20 volumio-viki volumio[1223]: info: sendMpdCommand status took 2 milliseconds Dec 15 10:47:20 volumio-viki volumio[1223]: info: sendMpdCommand status took 1 milliseconds Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: ControllerMpd::parseState Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: ControllerMpd::parseState Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: ControllerMpd::parseState Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 15 10:47:20 volumio-viki volumio[1223]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: ControllerMpd::parseTrackInfo Dec 15 10:47:20 volumio-viki volumio[1223]: info: ControllerMpd::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::servicePushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: 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":"288427.wav","artist":null,"album":null,"uri":"http://192.168.88.26:50002/m/NDLNA/288427.wav","trackType":"wav"} Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: CURRENT POSITION 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::syncState stateService stop Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::syncState currentStatus stop Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: No code Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: ------------------------------ 10ms Dec 15 10:47:20 volumio-viki volumio[1223]: info: sendMpdCommand playlistinfo took 12 milliseconds Dec 15 10:47:20 volumio-viki volumio[1223]: info: sendMpdCommand playlistinfo took 12 milliseconds Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: ControllerMpd::parseTrackInfo Dec 15 10:47:20 volumio-viki volumio[1223]: info: ControllerMpd::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::servicePushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: 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":"288427.wav","artist":null,"album":null,"uri":"http://192.168.88.26:50002/m/NDLNA/288427.wav","trackType":"wav"} Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: CURRENT POSITION 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::syncState stateService stop Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::syncState currentStatus stop Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: No code Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: ControllerMpd::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::servicePushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: 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":"288427.wav","artist":null,"album":null,"uri":"http://192.168.88.26:50002/m/NDLNA/288427.wav","trackType":"wav"} Dec 15 10:47:20 volumio-viki volumio[1223]: verbose: CURRENT POSITION 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::syncState stateService stop Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::syncState currentStatus stop Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: No code Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreStateMachine::pushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:47:20 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushState Dec 15 10:47:20 volumio-viki volumio[1223]: info: ------------------------------ 45ms Dec 15 10:47:20 volumio-viki volumio[1223]: info: ------------------------------ 45ms Dec 15 10:47:22 volumio-viki volumiologrotate[812]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Dec 15 10:47:22 volumio-viki volumiologrotate[812]: ls: cannot access 'VIKI': No such file or directory Dec 15 10:47:29 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:29 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:47:29 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:29 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:29 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:29 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:29 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:29 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:29 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:29 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:29 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::play index 1 Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:29 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:29 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:29 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:29 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:29 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:29 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:29 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:29 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:29 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:29 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:29 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:29 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 1 Dec 15 10:47:37 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:37 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:47:37 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:37 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:37 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:37 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:37 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:37 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:37 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:37 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:37 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:37 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:37 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::play index 2 Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:37 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:37 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:37 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:37 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:37 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:37 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:37 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:37 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:37 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:37 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 2 Dec 15 10:47:38 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:38 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:47:38 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:38 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:38 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:38 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:38 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:38 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:38 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:38 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:38 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:38 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:38 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::play index 2 Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:38 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:38 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:38 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:38 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:38 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:38 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:38 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:38 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:38 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:38 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 2 Dec 15 10:47:39 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:39 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:47:39 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:39 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:39 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:39 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:39 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288427 Dec 15 10:47:39 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:39 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288424 Dec 15 10:47:39 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:39 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288425 Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:39 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:39 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::play index 2 Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:47:39 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:47:39 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:47:39 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:39 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288426 Dec 15 10:47:39 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:39 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@288428 Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:47:39 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:47:39 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:47:39 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:47:39 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 2 Dec 15 10:47:55 volumio-viki volumio[1223]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 15 10:47:56 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:00 volumio-viki volumio[1223]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 15 10:48:00 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:00 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310872 Dec 15 10:48:00 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310873 Dec 15 10:48:00 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310874 Dec 15 10:48:00 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310875 Dec 15 10:48:00 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310876 Dec 15 10:48:00 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310877 Dec 15 10:48:00 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310878 Dec 15 10:48:00 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310879 Dec 15 10:48:00 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310880 Dec 15 10:48:00 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310872 in service upnp_browser Dec 15 10:48:00 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310873 in service upnp_browser Dec 15 10:48:00 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310874 in service upnp_browser Dec 15 10:48:00 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310875 in service upnp_browser Dec 15 10:48:00 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310876 in service upnp_browser Dec 15 10:48:01 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310877 in service upnp_browser Dec 15 10:48:01 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310878 in service upnp_browser Dec 15 10:48:01 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310879 in service upnp_browser Dec 15 10:48:01 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310880 in service upnp_browser Dec 15 10:48:03 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:03 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:48:03 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:48:03 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:48:03 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67092 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Exploding uri upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67092 in service upnp_browser Dec 15 10:48:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310872 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310872 Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:03 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:48:03 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::play index 1 Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:48:03 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:48:03 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310873 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310873 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310874 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310874 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310875 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310875 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310876 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310876 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310877 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310877 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310878 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310878 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310879 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310879 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310880 Dec 15 10:48:03 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310880 Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:03 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:03 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:48:03 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:48:03 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 1 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:14 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:48:14 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:48:14 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:48:14 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:14 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67092 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Using cached record of: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67092 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310872 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310872 Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:14 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:48:14 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::play index 1 Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:48:14 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:48:14 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:14 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310873 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310873 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310874 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310874 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310875 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310875 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310876 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310876 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310877 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310877 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310878 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310878 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310879 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310879 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310880 Dec 15 10:48:14 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310880 Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:14 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:14 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:48:14 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:48:14 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 1 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:19 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:48:19 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:48:19 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:48:19 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:19 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67092 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Using cached record of: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67092 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310872 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310872 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310873 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310873 Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:19 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:48:19 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::play index 2 Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:48:19 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:48:19 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:19 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310874 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310874 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310875 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310875 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310876 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310876 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310877 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310877 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310878 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310878 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310879 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310879 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310880 Dec 15 10:48:19 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@310880 Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:19 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:19 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:48:19 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:48:19 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 2 Dec 15 10:48:22 volumio-viki volumiologrotate[812]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Dec 15 10:48:22 volumio-viki volumiologrotate[812]: ls: cannot access 'VIKI': No such file or directory Dec 15 10:48:29 volumio-viki volumio[1223]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311755 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311756 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311757 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311758 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311759 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311760 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311761 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311762 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311687 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311688 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311689 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311690 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311691 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311692 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311693 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311694 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311695 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311696 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311697 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311698 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311699 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311700 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311701 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311702 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311703 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311704 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311705 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311706 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311707 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311708 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311709 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311710 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311711 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311712 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311713 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311714 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311715 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311716 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311717 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311718 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311719 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311720 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311721 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311722 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311723 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311724 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311725 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311726 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311727 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311728 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311729 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311730 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311731 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311732 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311733 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311734 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311735 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311736 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311737 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311738 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311739 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311740 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311741 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311742 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311743 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311744 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311745 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311746 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311747 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311748 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311749 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311750 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311751 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311752 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311753 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Preloading song: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311754 Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311755 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311756 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311757 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311758 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311759 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311760 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311761 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311762 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311687 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311688 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311689 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311690 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311691 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311692 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311693 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311694 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311695 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311696 in service upnp_browser Dec 15 10:48:30 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311697 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311698 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311699 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311700 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311701 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311702 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311703 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311704 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311705 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311706 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311707 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311708 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311709 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311710 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311711 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311712 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311713 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311714 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311715 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311716 in service upnp_browser Dec 15 10:48:31 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311717 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311718 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311719 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311720 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311721 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311722 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311723 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311724 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311725 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311726 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311727 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311728 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311729 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311730 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311731 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311732 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311733 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311734 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311735 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311736 in service upnp_browser Dec 15 10:48:32 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311737 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311738 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311739 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311740 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311741 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311742 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311743 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311744 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311745 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311746 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311747 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311748 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311749 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311750 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311751 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311752 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311753 in service upnp_browser Dec 15 10:48:33 volumio-viki volumio[1223]: info: Exploding uri upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311754 in service upnp_browser Dec 15 10:48:34 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:34 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:48:34 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:48:34 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:48:34 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67192 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Exploding uri upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67192 in service upnp_browser Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67193 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Exploding uri upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67193 in service upnp_browser Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67194 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Exploding uri upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67194 in service upnp_browser Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311755 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311755 Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:34 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:48:34 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::play index 3 Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:48:34 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:48:34 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311756 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311756 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311757 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311757 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311758 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311758 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311759 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311759 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311760 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311760 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311761 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311761 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311762 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311762 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311687 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311687 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311688 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311688 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311689 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311689 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311690 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311690 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311691 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311691 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311692 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311692 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311693 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311693 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311694 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311694 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311695 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311695 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311696 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311696 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311697 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311697 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311698 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311698 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311699 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311699 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311700 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311700 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311701 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311701 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311702 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311702 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311703 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311703 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311704 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311704 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311705 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311705 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311706 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311706 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311707 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311707 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311708 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311708 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311709 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311709 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311710 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311710 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311711 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311711 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311712 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311712 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311713 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311713 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311714 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311714 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311715 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311715 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311716 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311716 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311717 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311717 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311718 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311718 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311719 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311719 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311720 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311720 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311721 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311721 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311722 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311722 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311723 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311723 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311724 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311724 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311725 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311725 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311726 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311726 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311727 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311727 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311728 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311728 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311729 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311729 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311730 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311730 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311731 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311731 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311732 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311732 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311733 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311733 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311734 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311734 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311735 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311735 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311736 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311736 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311737 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311737 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311738 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311738 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311739 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311739 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311740 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311740 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311741 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311741 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311742 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311742 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311743 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311743 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311744 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311744 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311745 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311745 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311746 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311746 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311747 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311747 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311748 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311748 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311749 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311749 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311750 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311750 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311751 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311751 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311752 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311752 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311753 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311753 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311754 Dec 15 10:48:34 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311754 Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:34 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:34 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:48:34 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:48:34 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 3 Dec 15 10:48:44 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:48:44 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:48:44 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:44 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 0 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::ClearQueue Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:50 volumio-viki volumio[1223]: info: CorePlayQueue::clearPlayQueue Dec 15 10:48:50 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:48:50 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:48:50 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67192 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67192 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67193 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67193 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67194 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/folder/http://192.168.88.26:50001/ContentDirectory/control@22$67194 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311755 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311755 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311756 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311756 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311757 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311757 Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:50 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:48:50 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPlay Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::play index 5 Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::addQueueItems Dec 15 10:48:50 volumio-viki volumio[1223]: info: CorePlayQueue::addQueueItems Dec 15 10:48:50 volumio-viki volumio[1223]: info: Preload queue cleared Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311758 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311758 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311759 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311759 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311760 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311760 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311761 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311761 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311762 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311762 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311687 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311687 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311688 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311688 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311689 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311689 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311690 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311690 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311691 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311691 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311692 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311692 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311693 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311693 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311694 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311694 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311695 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311695 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311696 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311696 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311697 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311697 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311698 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311698 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311699 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311699 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311700 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311700 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311701 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311701 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311702 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311702 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311703 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311703 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311704 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311704 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311705 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311705 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311706 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311706 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311707 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311707 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311708 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311708 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311709 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311709 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311710 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311710 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311711 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311711 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311712 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311712 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311713 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311713 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311714 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311714 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311715 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311715 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311716 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311716 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311717 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311717 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311718 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311718 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311719 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311719 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311720 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311720 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311721 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311721 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311722 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311722 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311723 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311723 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311724 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311724 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311725 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311725 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311726 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311726 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311727 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311727 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311728 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311728 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311729 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311729 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311730 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311730 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311731 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311731 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311732 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311732 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311733 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311733 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311734 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311734 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311735 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311735 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311736 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311736 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311737 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311737 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311738 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311738 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311739 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311739 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311740 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311740 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311741 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311741 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311742 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311742 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311743 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311743 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311744 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311744 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311745 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311745 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311746 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311746 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311747 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311747 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311748 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311748 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311749 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311749 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311750 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311750 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311751 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311751 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311752 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311752 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311753 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311753 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Adding Item to queue: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311754 Dec 15 10:48:50 volumio-viki volumio[1223]: info: Using cached record of: upnp/http://192.168.88.26:50001/ContentDirectory/control@22$@311754 Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::stop Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreCommandRouter::volumioPushQueue Dec 15 10:48:50 volumio-viki volumio[1223]: info: CorePlayQueue::saveQueue Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::play index undefined Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 15 10:48:50 volumio-viki volumio[1223]: info: CoreStateMachine::updateTrackBlock Dec 15 10:48:50 volumio-viki volumio[1223]: info: CorePlayQueue::getTrackBlock Dec 15 10:48:50 volumio-viki volumio[1223]: info: CorePlayQueue::getTrack 5 Dec 15 10:48:53 volumio-viki volumio[1223]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Dec 15 10:48:53 volumio-viki volumio[1223]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 15 10:48:53 volumio-viki volumio[1223]: TypeError: Cannot read property 'length' of undefined Dec 15 10:48:53 volumio-viki volumio[1223]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Dec 15 10:48:53 volumio-viki volumio[1223]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Dec 15 10:48:53 volumio-viki volumio[1223]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Dec 15 10:48:53 volumio-viki volumio[1223]: at Parser.emit (events.js:400:28) Dec 15 10:48:53 volumio-viki volumio[1223]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Dec 15 10:48:53 volumio-viki volumio[1223]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Dec 15 10:48:53 volumio-viki volumio[1223]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Dec 15 10:48:53 volumio-viki volumio[1223]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Dec 15 10:48:53 volumio-viki volumio[1223]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Dec 15 10:48:53 volumio-viki volumio[1223]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Dec 15 10:48:53 volumio-viki volumio[1223]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Dec 15 10:48:53 volumio-viki volumio[1223]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Dec 15 10:48:53 volumio-viki volumio[1223]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Dec 15 10:48:53 volumio-viki volumio[1223]: at IncomingMessage.emit (events.js:412:35) Dec 15 10:48:53 volumio-viki volumio[1223]: at endReadableNT (internal/streams/readable.js:1333:12) Dec 15 10:48:53 volumio-viki volumio[1223]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Dec 15 10:48:53 volumio-viki volumio[1223]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 15 10:48:53 volumio-viki sudo[26996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-15 10:47 Dec 15 10:48:53 volumio-viki sudo[26996]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"