-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sat 2025-03-08 19:05:56 CET. -- Mar 08 19:04:04 volumio volumio[921]: info: Preload queue cleared Mar 08 19:04:04 volumio volumio[921]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::ClearQueue Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::stop Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::stPlaybackTimer Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:04:04 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:04 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:04 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:04 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:04 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:04 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::serviceStop Mar 08 19:04:04 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:04 volumio volumio[921]: info: CoreCommandRouter::serviceStop Mar 08 19:04:04 volumio volumio[921]: info: ControllerMpd::stop Mar 08 19:04:04 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:04:04 volumio volumio[921]: info: CorePlayQueue::clearPlayQueue Mar 08 19:04:04 volumio volumio[921]: info: CorePlayQueue::saveQueue Mar 08 19:04:04 volumio volumio[921]: info: CoreCommandRouter::volumioPushQueue Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::addQueueItems Mar 08 19:04:04 volumio volumio[921]: info: CorePlayQueue::addQueueItems Mar 08 19:04:04 volumio volumio[921]: info: Preload queue cleared Mar 08 19:04:04 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980) Mar 08 19:04:04 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980) Mar 08 19:04:04 volumio volumio[921]: info: CoreCommandRouter::volumioPushQueue Mar 08 19:04:04 volumio volumio[921]: info: CorePlayQueue::saveQueue Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:04:04 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:04:04 volumio volumio[921]: info: CoreCommandRouter::volumioPlay Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::play index 0 Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::stop Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::play index undefined Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:04:04 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:04 volumio volumio[921]: info: CoreStateMachine::startPlaybackTimer Mar 08 19:04:04 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:04 volumio volumio[921]: verbose: ControllerMpd::clearAddPlayTracks NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/1 - Guilty (Feat Barry Gibb).flac Mar 08 19:04:04 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:04:04 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:04 volumio volumio[921]: info: Mar 08 19:04:04 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:04 volumio volumio[921]: info: sendMpdCommand stop took 21 milliseconds Mar 08 19:04:04 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:04 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:04 volumio volumio[921]: info: sendMpdCommand stop took 14 milliseconds Mar 08 19:04:04 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 19:04:04 volumio volumio[921]: info: Mar 08 19:04:04 volumio volumio[921]: ---------------------------- MPD announces system playlist update Mar 08 19:04:04 volumio volumio[921]: info: Ignoring MPD Status Update Mar 08 19:04:04 volumio volumio[921]: info: sendMpdCommand status took 2 milliseconds Mar 08 19:04:04 volumio volumio[921]: info: sendMpdCommand clear took 2 milliseconds Mar 08 19:04:04 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:04 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:04 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand add "NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/1 - Guilty (Feat Barry Gibb).flac" Mar 08 19:04:04 volumio volumio[921]: error: updateQueue error: null Mar 08 19:04:04 volumio volumio[921]: info: Mar 08 19:04:04 volumio volumio[921]: ---------------------------- MPD announces system playlist update Mar 08 19:04:04 volumio volumio[921]: info: Ignoring MPD Status Update Mar 08 19:04:04 volumio volumio[921]: info: ------------------------------ 1ms Mar 08 19:04:04 volumio volumio[921]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 19:04:04 volumio volumio[921]: info: sendMpdCommand add "NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/1 - Guilty (Feat Barry Gibb).flac" took 2 milliseconds Mar 08 19:04:04 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:04 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand play Mar 08 19:04:04 volumio volumio[921]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 08 19:04:04 volumio volumio[921]: info: ------------------------------ 5ms Mar 08 19:04:04 volumio volumio[921]: info: ------------------------------ 3ms Mar 08 19:04:04 volumio volumio[921]: info: sendMpdCommand play took 2 milliseconds Mar 08 19:04:05 volumio volumio[921]: info: Mar 08 19:04:05 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:05 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:05 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:05 volumio volumio[921]: info: Mar 08 19:04:05 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:05 volumio volumio[921]: info: sendMpdCommand status took 2 milliseconds Mar 08 19:04:05 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:05 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:05 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:05 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:05 volumio volumio[921]: info: sendMpdCommand status took 1 milliseconds Mar 08 19:04:05 volumio volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 19:04:05 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:05 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:05 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:05 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:05 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:05 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:05 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Guilty (Feat Barry Gibb)","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/1 - Guilty (Feat Barry Gibb).flac","trackType":"flac"} Mar 08 19:04:05 volumio volumio[921]: verbose: CURRENT POSITION 0 Mar 08 19:04:05 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:05 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop Mar 08 19:04:05 volumio volumio[921]: info: ------------------------------ 5ms Mar 08 19:04:05 volumio volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 19:04:05 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:05 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:05 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:05 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:05 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Guilty (Feat Barry Gibb)","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/1 - Guilty (Feat Barry Gibb).flac","trackType":"flac"} Mar 08 19:04:05 volumio volumio[921]: verbose: CURRENT POSITION 0 Mar 08 19:04:05 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:05 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus play Mar 08 19:04:05 volumio volumio[921]: info: Received an update from plugin. extracting info from payload Mar 08 19:04:05 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:05 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:05 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:05 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:05 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:05 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:05 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:05 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:05 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:05 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:05 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:05 volumio volumio[921]: info: ------------------------------ 17ms Mar 08 19:04:05 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:05 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:06 volumio volumio[921]: info: MPD Database updated - AlbumList cache refreshed Mar 08 19:04:06 volumio volumio[921]: info: Mar 08 19:04:06 volumio volumio[921]: ---------------------------- MPD announces state update: database Mar 08 19:04:06 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:06 volumio volumio[921]: info: Mar 08 19:04:06 volumio volumio[921]: ---------------------------- MPD announces state update: update Mar 08 19:04:06 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:06 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:06 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:06 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:06 volumio volumio[921]: info: sendMpdCommand status took 78 milliseconds Mar 08 19:04:06 volumio volumio[921]: info: sendMpdCommand status took 79 milliseconds Mar 08 19:04:06 volumio volumio[921]: info: sendMpdCommand status took 79 milliseconds Mar 08 19:04:06 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:06 volumio volumio[921]: info: Command Router : Notfying DB Updatefalse Mar 08 19:04:06 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent Mar 08 19:04:06 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:06 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:06 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:06 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:06 volumio volumio[921]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 19:04:06 volumio volumio[921]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 19:04:06 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:06 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:06 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:06 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:06 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:06 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3226,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"790 Kbps","isStreaming":false,"title":"Guilty (Feat Barry Gibb)","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/1 - Guilty (Feat Barry Gibb).flac","trackType":"flac"} Mar 08 19:04:06 volumio volumio[921]: verbose: CURRENT POSITION 0 Mar 08 19:04:06 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:06 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus play Mar 08 19:04:06 volumio volumio[921]: info: Received an update from plugin. extracting info from payload Mar 08 19:04:06 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:06 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:06 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:06 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:06 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:06 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:06 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:06 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:06 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:06 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:06 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:06 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:06 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:06 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:06 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3226,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"790 Kbps","isStreaming":false,"title":"Guilty (Feat Barry Gibb)","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/1 - Guilty (Feat Barry Gibb).flac","trackType":"flac"} Mar 08 19:04:06 volumio volumio[921]: verbose: CURRENT POSITION 0 Mar 08 19:04:06 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:06 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus play Mar 08 19:04:06 volumio volumio[921]: info: Received an update from plugin. extracting info from payload Mar 08 19:04:06 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:06 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:06 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:06 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:06 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:06 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:06 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:06 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:06 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:06 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:06 volumio volumio[921]: info: ------------------------------ 144ms Mar 08 19:04:06 volumio volumio[921]: info: ------------------------------ 144ms Mar 08 19:04:06 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:06 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:06 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:06 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::volumioNext Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::next Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::stop Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::stPlaybackTimer Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:07 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:07 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::serviceStop Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::serviceStop Mar 08 19:04:07 volumio volumio[921]: info: ControllerMpd::stop Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:04:07 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:07 volumio volumio[921]: info: Mar 08 19:04:07 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:07 volumio volumio[921]: info: sendMpdCommand stop took 16 milliseconds Mar 08 19:04:07 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::play index undefined Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrack 1 Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::startPlaybackTimer Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrack 1 Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::clearAddPlayTracks NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/2 - Woman In Love.flac Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:04:07 volumio volumio[921]: info: sendMpdCommand status took 2 milliseconds Mar 08 19:04:07 volumio volumio[921]: info: sendMpdCommand stop took 1 milliseconds Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 19:04:07 volumio volumio[921]: info: Mar 08 19:04:07 volumio volumio[921]: ---------------------------- MPD announces system playlist update Mar 08 19:04:07 volumio volumio[921]: info: Ignoring MPD Status Update Mar 08 19:04:07 volumio volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 19:04:07 volumio volumio[921]: info: sendMpdCommand clear took 1 milliseconds Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand add "NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/2 - Woman In Love.flac" Mar 08 19:04:07 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrack 1 Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:07 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:07 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrack 1 Mar 08 19:04:07 volumio volumio[921]: 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":"Guilty (Feat Barry Gibb)","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/1 - Guilty (Feat Barry Gibb).flac","trackType":"flac"} Mar 08 19:04:07 volumio volumio[921]: verbose: CURRENT POSITION 1 Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrack 1 Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:07 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:07 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:07 volumio volumio[921]: info: No code Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrack 1 Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:07 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:07 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:07 volumio volumio[921]: info: ------------------------------ 15ms Mar 08 19:04:07 volumio volumio[921]: error: updateQueue error: null Mar 08 19:04:07 volumio volumio[921]: info: Mar 08 19:04:07 volumio volumio[921]: ---------------------------- MPD announces system playlist update Mar 08 19:04:07 volumio volumio[921]: info: Ignoring MPD Status Update Mar 08 19:04:07 volumio volumio[921]: info: ------------------------------ 12ms Mar 08 19:04:07 volumio volumio[921]: info: sendMpdCommand add "NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/2 - Woman In Love.flac" took 11 milliseconds Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand play Mar 08 19:04:07 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:07 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:07 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:07 volumio volumio[921]: info: ------------------------------ 10ms Mar 08 19:04:07 volumio volumio[921]: info: sendMpdCommand play took 10 milliseconds Mar 08 19:04:07 volumio volumio[921]: info: Mar 08 19:04:07 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:07 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:07 volumio volumio[921]: info: Mar 08 19:04:07 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:07 volumio volumio[921]: info: sendMpdCommand status took 4 milliseconds Mar 08 19:04:07 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:07 volumio volumio[921]: info: sendMpdCommand status took 1 milliseconds Mar 08 19:04:07 volumio volumio[921]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:07 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrack 1 Mar 08 19:04:07 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Woman in Love","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/2 - Woman In Love.flac","trackType":"flac"} Mar 08 19:04:07 volumio volumio[921]: verbose: CURRENT POSITION 1 Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop Mar 08 19:04:07 volumio volumio[921]: info: ------------------------------ 8ms Mar 08 19:04:07 volumio volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 19:04:07 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:07 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrack 1 Mar 08 19:04:07 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Woman in Love","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/2 - Woman In Love.flac","trackType":"flac"} Mar 08 19:04:07 volumio volumio[921]: verbose: CURRENT POSITION 1 Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus play Mar 08 19:04:07 volumio volumio[921]: info: Received an update from plugin. extracting info from payload Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrack 1 Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:07 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:07 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:07 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:07 volumio volumio[921]: info: CorePlayQueue::getTrack 1 Mar 08 19:04:07 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:07 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:07 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:07 volumio volumio[921]: info: ------------------------------ 11ms Mar 08 19:04:07 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:07 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::volumioNext Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::next Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::stop Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::stPlaybackTimer Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrack 1 Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:11 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:11 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::serviceStop Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrack 1 Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::serviceStop Mar 08 19:04:11 volumio volumio[921]: info: ControllerMpd::stop Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:04:11 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:11 volumio volumio[921]: info: Mar 08 19:04:11 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:11 volumio volumio[921]: info: sendMpdCommand stop took 21 milliseconds Mar 08 19:04:11 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::play index undefined Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrack 2 Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::startPlaybackTimer Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrack 2 Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::clearAddPlayTracks NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/3 - Run Wild.flac Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:04:11 volumio volumio[921]: info: sendMpdCommand status took 1 milliseconds Mar 08 19:04:11 volumio volumio[921]: info: sendMpdCommand stop took 0 milliseconds Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 19:04:11 volumio volumio[921]: info: Mar 08 19:04:11 volumio volumio[921]: ---------------------------- MPD announces system playlist update Mar 08 19:04:11 volumio volumio[921]: info: Ignoring MPD Status Update Mar 08 19:04:11 volumio volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 19:04:11 volumio volumio[921]: info: sendMpdCommand clear took 1 milliseconds Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand add "NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/3 - Run Wild.flac" Mar 08 19:04:11 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrack 2 Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:11 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:11 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrack 2 Mar 08 19:04:11 volumio volumio[921]: 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":"Woman in Love","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/2 - Woman In Love.flac","trackType":"flac"} Mar 08 19:04:11 volumio volumio[921]: verbose: CURRENT POSITION 2 Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::syncState stateService stop Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrack 2 Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:11 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:11 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:11 volumio volumio[921]: info: No code Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrack 2 Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:11 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:11 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:11 volumio volumio[921]: info: ------------------------------ 14ms Mar 08 19:04:11 volumio volumio[921]: error: updateQueue error: null Mar 08 19:04:11 volumio volumio[921]: info: Mar 08 19:04:11 volumio volumio[921]: ---------------------------- MPD announces system playlist update Mar 08 19:04:11 volumio volumio[921]: info: Ignoring MPD Status Update Mar 08 19:04:11 volumio volumio[921]: info: ------------------------------ 12ms Mar 08 19:04:11 volumio volumio[921]: info: sendMpdCommand add "NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/3 - Run Wild.flac" took 11 milliseconds Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand play Mar 08 19:04:11 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:11 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:11 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:11 volumio volumio[921]: info: ------------------------------ 13ms Mar 08 19:04:11 volumio volumio[921]: info: sendMpdCommand play took 13 milliseconds Mar 08 19:04:11 volumio volumio[921]: info: Mar 08 19:04:11 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:11 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:11 volumio volumio[921]: info: Mar 08 19:04:11 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:11 volumio volumio[921]: info: sendMpdCommand status took 4 milliseconds Mar 08 19:04:11 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:11 volumio volumio[921]: info: sendMpdCommand status took 1 milliseconds Mar 08 19:04:11 volumio volumio[921]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:11 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrack 2 Mar 08 19:04:11 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Run Wild","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/3 - Run Wild.flac","trackType":"flac"} Mar 08 19:04:11 volumio volumio[921]: verbose: CURRENT POSITION 2 Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop Mar 08 19:04:11 volumio volumio[921]: info: ------------------------------ 6ms Mar 08 19:04:11 volumio volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 19:04:11 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:11 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrack 2 Mar 08 19:04:11 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Run Wild","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/3 - Run Wild.flac","trackType":"flac"} Mar 08 19:04:11 volumio volumio[921]: verbose: CURRENT POSITION 2 Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus play Mar 08 19:04:11 volumio volumio[921]: info: Received an update from plugin. extracting info from payload Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrack 2 Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:11 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:11 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:11 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:11 volumio volumio[921]: info: CorePlayQueue::getTrack 2 Mar 08 19:04:11 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:11 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:11 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:11 volumio volumio[921]: info: ------------------------------ 10ms Mar 08 19:04:11 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:11 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:13 volumio volumio[921]: info: CoreCommandRouter::volumioNext Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::next Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::stop Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::stPlaybackTimer Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:04:13 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:13 volumio volumio[921]: info: CorePlayQueue::getTrack 2 Mar 08 19:04:13 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:13 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:13 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:13 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::serviceStop Mar 08 19:04:13 volumio volumio[921]: info: CorePlayQueue::getTrack 2 Mar 08 19:04:13 volumio volumio[921]: info: CoreCommandRouter::serviceStop Mar 08 19:04:13 volumio volumio[921]: info: ControllerMpd::stop Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:04:13 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:13 volumio volumio[921]: info: sendMpdCommand stop took 19 milliseconds Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::play index undefined Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:04:13 volumio volumio[921]: info: CorePlayQueue::getTrack 3 Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::startPlaybackTimer Mar 08 19:04:13 volumio volumio[921]: info: CorePlayQueue::getTrack 3 Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::clearAddPlayTracks NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/4 - Promises.flac Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:04:13 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:04:13 volumio volumio[921]: info: Mar 08 19:04:13 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:13 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:13 volumio volumio[921]: info: sendMpdCommand stop took 1 milliseconds Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 19:04:13 volumio volumio[921]: info: Mar 08 19:04:13 volumio volumio[921]: ---------------------------- MPD announces system playlist update Mar 08 19:04:13 volumio volumio[921]: info: Ignoring MPD Status Update Mar 08 19:04:13 volumio volumio[921]: info: sendMpdCommand status took 1 milliseconds Mar 08 19:04:13 volumio volumio[921]: info: sendMpdCommand clear took 1 milliseconds Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand add "NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/4 - Promises.flac" Mar 08 19:04:13 volumio volumio[921]: error: updateQueue error: null Mar 08 19:04:13 volumio volumio[921]: info: Mar 08 19:04:13 volumio volumio[921]: ---------------------------- MPD announces system playlist update Mar 08 19:04:13 volumio volumio[921]: info: Ignoring MPD Status Update Mar 08 19:04:13 volumio volumio[921]: info: ------------------------------ 1ms Mar 08 19:04:13 volumio volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 19:04:13 volumio volumio[921]: info: sendMpdCommand add "NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/4 - Promises.flac" took 1 milliseconds Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand play Mar 08 19:04:13 volumio volumio[921]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 08 19:04:13 volumio volumio[921]: info: ------------------------------ 4ms Mar 08 19:04:13 volumio volumio[921]: info: ------------------------------ 2ms Mar 08 19:04:13 volumio volumio[921]: info: sendMpdCommand play took 1 milliseconds Mar 08 19:04:13 volumio volumio[921]: info: Mar 08 19:04:13 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:13 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:13 volumio volumio[921]: info: Mar 08 19:04:13 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:13 volumio volumio[921]: info: sendMpdCommand status took 4 milliseconds Mar 08 19:04:13 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:13 volumio volumio[921]: info: sendMpdCommand status took 3 milliseconds Mar 08 19:04:13 volumio volumio[921]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:13 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:13 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:13 volumio volumio[921]: info: CorePlayQueue::getTrack 3 Mar 08 19:04:13 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":263,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Promises","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/4 - Promises.flac","trackType":"flac"} Mar 08 19:04:13 volumio volumio[921]: verbose: CURRENT POSITION 3 Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop Mar 08 19:04:13 volumio volumio[921]: info: ------------------------------ 10ms Mar 08 19:04:13 volumio volumio[921]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 19:04:13 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:13 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:13 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:13 volumio volumio[921]: info: CorePlayQueue::getTrack 3 Mar 08 19:04:13 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":263,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Promises","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/4 - Promises.flac","trackType":"flac"} Mar 08 19:04:13 volumio volumio[921]: verbose: CURRENT POSITION 3 Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus play Mar 08 19:04:13 volumio volumio[921]: info: Received an update from plugin. extracting info from payload Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:13 volumio volumio[921]: info: CorePlayQueue::getTrack 3 Mar 08 19:04:13 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:13 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:13 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:13 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:13 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:13 volumio volumio[921]: info: CorePlayQueue::getTrack 3 Mar 08 19:04:13 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:13 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:13 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:13 volumio volumio[921]: info: ------------------------------ 14ms Mar 08 19:04:13 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:13 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:20 volumio volumio[921]: info: CoreCommandRouter::volumioNext Mar 08 19:04:20 volumio volumio[921]: info: CoreStateMachine::next Mar 08 19:04:20 volumio volumio[921]: info: CoreStateMachine::stop Mar 08 19:04:20 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:04:20 volumio volumio[921]: info: CoreStateMachine::stPlaybackTimer Mar 08 19:04:20 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:04:20 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:04:20 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:20 volumio volumio[921]: info: CorePlayQueue::getTrack 3 Mar 08 19:04:20 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:20 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:20 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:20 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:20 volumio volumio[921]: info: CoreStateMachine::serviceStop Mar 08 19:04:20 volumio volumio[921]: info: CorePlayQueue::getTrack 3 Mar 08 19:04:20 volumio volumio[921]: info: CoreCommandRouter::serviceStop Mar 08 19:04:20 volumio volumio[921]: info: ControllerMpd::stop Mar 08 19:04:20 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:04:20 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:21 volumio volumio[921]: info: sendMpdCommand stop took 24 milliseconds Mar 08 19:04:21 volumio volumio[921]: info: CoreStateMachine::play index undefined Mar 08 19:04:21 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:04:21 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:04:21 volumio volumio[921]: info: CoreStateMachine::startPlaybackTimer Mar 08 19:04:21 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::clearAddPlayTracks NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/5 - The Love Inside.flac Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:04:21 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:04:21 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:04:21 volumio volumio[921]: info: Mar 08 19:04:21 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:21 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:21 volumio volumio[921]: info: sendMpdCommand stop took 1 milliseconds Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 19:04:21 volumio volumio[921]: info: Mar 08 19:04:21 volumio volumio[921]: ---------------------------- MPD announces system playlist update Mar 08 19:04:21 volumio volumio[921]: info: Ignoring MPD Status Update Mar 08 19:04:21 volumio volumio[921]: info: sendMpdCommand status took 1 milliseconds Mar 08 19:04:21 volumio volumio[921]: info: sendMpdCommand clear took 1 milliseconds Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand add "NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/5 - The Love Inside.flac" Mar 08 19:04:21 volumio volumio[921]: error: updateQueue error: null Mar 08 19:04:21 volumio volumio[921]: info: Mar 08 19:04:21 volumio volumio[921]: ---------------------------- MPD announces system playlist update Mar 08 19:04:21 volumio volumio[921]: info: Ignoring MPD Status Update Mar 08 19:04:21 volumio volumio[921]: info: ------------------------------ 2ms Mar 08 19:04:21 volumio volumio[921]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 19:04:21 volumio volumio[921]: info: sendMpdCommand add "NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/5 - The Love Inside.flac" took 2 milliseconds Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand play Mar 08 19:04:21 volumio volumio[921]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 08 19:04:21 volumio volumio[921]: info: ------------------------------ 4ms Mar 08 19:04:21 volumio volumio[921]: info: ------------------------------ 2ms Mar 08 19:04:21 volumio volumio[921]: info: sendMpdCommand play took 2 milliseconds Mar 08 19:04:21 volumio volumio[921]: info: Mar 08 19:04:21 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:21 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:21 volumio volumio[921]: info: Mar 08 19:04:21 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:04:21 volumio volumio[921]: info: sendMpdCommand status took 3 milliseconds Mar 08 19:04:21 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:21 volumio volumio[921]: info: sendMpdCommand status took 0 milliseconds Mar 08 19:04:21 volumio volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:21 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:21 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:21 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:04:21 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":305,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Love Inside","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/5 - The Love Inside.flac","trackType":"flac"} Mar 08 19:04:21 volumio volumio[921]: verbose: CURRENT POSITION 4 Mar 08 19:04:21 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:21 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop Mar 08 19:04:21 volumio volumio[921]: info: ------------------------------ 6ms Mar 08 19:04:21 volumio volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 19:04:21 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:21 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:21 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:21 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:04:21 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":305,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Love Inside","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/5 - The Love Inside.flac","trackType":"flac"} Mar 08 19:04:21 volumio volumio[921]: verbose: CURRENT POSITION 4 Mar 08 19:04:21 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:21 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus play Mar 08 19:04:21 volumio volumio[921]: info: Received an update from plugin. extracting info from payload Mar 08 19:04:21 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:21 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:04:21 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:21 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:21 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:21 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:21 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:21 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:04:21 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:21 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:21 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:21 volumio volumio[921]: info: ------------------------------ 15ms Mar 08 19:04:21 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:21 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:58 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 08 19:04:58 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand update Mar 08 19:04:58 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:58 volumio volumio[921]: info: Mar 08 19:04:58 volumio volumio[921]: ---------------------------- MPD announces state update: update Mar 08 19:04:58 volumio volumio[921]: info: sendMpdCommand update took 2 milliseconds Mar 08 19:04:58 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:04:58 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:04:58 volumio volumio[921]: info: sendMpdCommand status took 2 milliseconds Mar 08 19:04:58 volumio volumio[921]: info: sendMpdCommand status took 1 milliseconds Mar 08 19:04:58 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:58 volumio volumio[921]: info: Command Router : Notfying DB Updatetrue Mar 08 19:04:58 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent Mar 08 19:04:58 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:04:58 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:04:58 volumio volumio[921]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 08 19:04:58 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:04:58 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:04:58 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:04:58 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:04:58 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":38598,"duration":305,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"969 Kbps","isStreaming":false,"title":"The Love Inside","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/5 - The Love Inside.flac","trackType":"flac"} Mar 08 19:04:58 volumio volumio[921]: verbose: CURRENT POSITION 4 Mar 08 19:04:58 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:04:58 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus play Mar 08 19:04:58 volumio volumio[921]: info: Received an update from plugin. extracting info from payload Mar 08 19:04:58 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:58 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:04:58 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:04:58 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:58 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:58 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:58 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:04:58 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:04:58 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:04:58 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:04:58 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:04:58 volumio volumio[921]: info: ------------------------------ 51ms Mar 08 19:04:58 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:04:58 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:05:00 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 08 19:05:00 volumio volumio[921]: info: CURURI: music-library/NAS/Volume_1/musica Mar 08 19:05:00 volumio volumio[921]: info: Preload queue cleared Mar 08 19:05:17 volumio volumio[921]: info: MPD Database updated - AlbumList cache refreshed Mar 08 19:05:17 volumio volumio[921]: info: Mar 08 19:05:17 volumio volumio[921]: ---------------------------- MPD announces state update: database Mar 08 19:05:17 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:05:17 volumio volumio[921]: info: Mar 08 19:05:17 volumio volumio[921]: ---------------------------- MPD announces state update: update Mar 08 19:05:17 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:05:17 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:05:17 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:05:17 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:05:17 volumio volumio[921]: info: sendMpdCommand status took 74 milliseconds Mar 08 19:05:17 volumio volumio[921]: info: sendMpdCommand status took 73 milliseconds Mar 08 19:05:17 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:05:17 volumio volumio[921]: info: Command Router : Notfying DB Updatefalse Mar 08 19:05:17 volumio volumio[921]: info: CoreCommandRouter::Close All Modals sent Mar 08 19:05:17 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:05:17 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:05:17 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:05:17 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:05:17 volumio volumio[921]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 08 19:05:17 volumio volumio[921]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 08 19:05:17 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:05:17 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:05:17 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:05:17 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:05:17 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:05:17 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57702,"duration":305,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"664 Kbps","isStreaming":false,"title":"The Love Inside","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/5 - The Love Inside.flac","trackType":"flac"} Mar 08 19:05:17 volumio volumio[921]: verbose: CURRENT POSITION 4 Mar 08 19:05:17 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:05:17 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus play Mar 08 19:05:17 volumio volumio[921]: info: Received an update from plugin. extracting info from payload Mar 08 19:05:17 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:05:17 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:05:17 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:05:17 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:05:17 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:05:17 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:05:17 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:05:17 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:05:17 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:05:17 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:05:17 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:05:17 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:05:17 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:05:17 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:05:17 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57702,"duration":305,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"665 Kbps","isStreaming":false,"title":"The Love Inside","artist":"BARBRA STREISAND","album":"GUILTY","uri":"NAS/Volume_1/musica/BARBRA STREISAND - 22 - GUILTY (1980)/5 - The Love Inside.flac","trackType":"flac"} Mar 08 19:05:17 volumio volumio[921]: verbose: CURRENT POSITION 4 Mar 08 19:05:17 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:05:17 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus play Mar 08 19:05:17 volumio volumio[921]: info: Received an update from plugin. extracting info from payload Mar 08 19:05:17 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:05:17 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:05:17 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:05:17 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:05:17 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:05:17 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:05:17 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:05:17 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:05:17 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:05:17 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:05:17 volumio volumio[921]: info: ------------------------------ 144ms Mar 08 19:05:17 volumio volumio[921]: info: ------------------------------ 148ms Mar 08 19:05:17 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:05:17 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:05:34 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 08 19:05:34 volumio volumio[921]: info: CURURI: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989) Mar 08 19:05:34 volumio volumio[921]: info: Preload queue cleared Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/01 - Blew.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/02 - Floyd The Barber.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/03 - About A Girl.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/04 - School.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/05 - Love Buzz.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/06 - Paper Cuts.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/07 - Negative Creep.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/08 - Scoff.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/09 - Swap Meet.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/10 - Mr. Moustache.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/11 - Sifting.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/12 - Big Cheese.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/13 - Downer.flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/24 - Been A Son (Blew EP Version).flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/14 - Intro (Live At Pine Street Theatre).flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/15 - School (Live At Pine Street Theatre).flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/16 - Floyd The Barber (Live At Pine Street Theatre).flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/17 - Dive (Live At Pine Street Theatre).flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/18 - Love Buzz (Live At Pine Street Theatre).flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/19 - Spank Thru (Live At Pine Street Theatre).flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/20 - Molly's Lips (Live At Pine Street Theatre).flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/21 - Sappy (Live At Pine Street Theatre).flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/22 - Scoff (Live At Pine Street Theatre).flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/23 - About A Girl (Live At Pine Street Theatre).flac Mar 08 19:05:34 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/24 - Been A Son (Live At Pine Street Theatre).flac Mar 08 19:05:35 volumio volumio[921]: info: Preloading song: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/25 - Blew (Live At Pine Street Theatre).flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/01 - Blew.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F01%20-%20Blew.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/01 - Blew.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/02 - Floyd The Barber.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F02%20-%20Floyd%20The%20Barber.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/02 - Floyd The Barber.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/03 - About A Girl.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F03%20-%20About%20A%20Girl.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/03 - About A Girl.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/04 - School.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F04%20-%20School.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/04 - School.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/05 - Love Buzz.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F05%20-%20Love%20Buzz.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/05 - Love Buzz.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/06 - Paper Cuts.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F06%20-%20Paper%20Cuts.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/06 - Paper Cuts.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/07 - Negative Creep.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F07%20-%20Negative%20Creep.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/07 - Negative Creep.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/08 - Scoff.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F08%20-%20Scoff.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/08 - Scoff.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/09 - Swap Meet.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F09%20-%20Swap%20Meet.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/09 - Swap Meet.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/10 - Mr. Moustache.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F10%20-%20Mr.%20Moustache.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/10 - Mr. Moustache.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/11 - Sifting.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F11%20-%20Sifting.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/11 - Sifting.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/12 - Big Cheese.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F12%20-%20Big%20Cheese.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/12 - Big Cheese.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/13 - Downer.flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F13%20-%20Downer.flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/13 - Downer.flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/24 - Been A Son (Blew EP Version).flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F24%20-%20Been%20A%20Son%20(Blew%20EP%20Version).flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/24 - Been A Son (Blew EP Version).flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/14 - Intro (Live At Pine Street Theatre).flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22%20%5B20th%20ANNIVERSARY%5D/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F14%20-%20Intro%20(Live%20At%20Pine%20Street%20Theatre).flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/14 - Intro (Live At Pine Street Theatre).flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/15 - School (Live At Pine Street Theatre).flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22%20%5B20th%20ANNIVERSARY%5D/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F15%20-%20School%20(Live%20At%20Pine%20Street%20Theatre).flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/15 - School (Live At Pine Street Theatre).flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/16 - Floyd The Barber (Live At Pine Street Theatre).flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22%20%5B20th%20ANNIVERSARY%5D/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F16%20-%20Floyd%20The%20Barber%20(Live%20At%20Pine%20Street%20Theatre).flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/16 - Floyd The Barber (Live At Pine Street Theatre).flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/17 - Dive (Live At Pine Street Theatre).flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22%20%5B20th%20ANNIVERSARY%5D/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F17%20-%20Dive%20(Live%20At%20Pine%20Street%20Theatre).flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/17 - Dive (Live At Pine Street Theatre).flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/18 - Love Buzz (Live At Pine Street Theatre).flac in service mpd Mar 08 19:05:35 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22%20%5B20th%20ANNIVERSARY%5D/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F18%20-%20Love%20Buzz%20(Live%20At%20Pine%20Street%20Theatre).flac&metadata=false Mar 08 19:05:35 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/18 - Love Buzz (Live At Pine Street Theatre).flac Mar 08 19:05:35 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/19 - Spank Thru (Live At Pine Street Theatre).flac in service mpd Mar 08 19:05:36 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22%20%5B20th%20ANNIVERSARY%5D/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F19%20-%20Spank%20Thru%20(Live%20At%20Pine%20Street%20Theatre).flac&metadata=false Mar 08 19:05:36 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/19 - Spank Thru (Live At Pine Street Theatre).flac Mar 08 19:05:36 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/20 - Molly's Lips (Live At Pine Street Theatre).flac in service mpd Mar 08 19:05:36 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22%20%5B20th%20ANNIVERSARY%5D/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F20%20-%20Molly's%20Lips%20(Live%20At%20Pine%20Street%20Theatre).flac&metadata=false Mar 08 19:05:36 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/20 - Molly's Lips (Live At Pine Street Theatre).flac Mar 08 19:05:36 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/21 - Sappy (Live At Pine Street Theatre).flac in service mpd Mar 08 19:05:36 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22%20%5B20th%20ANNIVERSARY%5D/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F21%20-%20Sappy%20(Live%20At%20Pine%20Street%20Theatre).flac&metadata=false Mar 08 19:05:36 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/21 - Sappy (Live At Pine Street Theatre).flac Mar 08 19:05:36 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/22 - Scoff (Live At Pine Street Theatre).flac in service mpd Mar 08 19:05:36 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22%20%5B20th%20ANNIVERSARY%5D/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F22%20-%20Scoff%20(Live%20At%20Pine%20Street%20Theatre).flac&metadata=false Mar 08 19:05:36 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/22 - Scoff (Live At Pine Street Theatre).flac Mar 08 19:05:36 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/23 - About A Girl (Live At Pine Street Theatre).flac in service mpd Mar 08 19:05:36 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22%20%5B20th%20ANNIVERSARY%5D/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F23%20-%20About%20A%20Girl%20(Live%20At%20Pine%20Street%20Theatre).flac&metadata=false Mar 08 19:05:36 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/23 - About A Girl (Live At Pine Street Theatre).flac Mar 08 19:05:36 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/24 - Been A Son (Live At Pine Street Theatre).flac in service mpd Mar 08 19:05:36 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22%20%5B20th%20ANNIVERSARY%5D/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F24%20-%20Been%20A%20Son%20(Live%20At%20Pine%20Street%20Theatre).flac&metadata=false Mar 08 19:05:36 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/24 - Been A Son (Live At Pine Street Theatre).flac Mar 08 19:05:36 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/25 - Blew (Live At Pine Street Theatre).flac in service mpd Mar 08 19:05:36 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=NIRVANA/%22BLEACH%22%20%5B20th%20ANNIVERSARY%5D/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FNIRVANA%20-%2001%20-%20BLEACH%20(1989)%2F25%20-%20Blew%20(Live%20At%20Pine%20Street%20Theatre).flac&metadata=false Mar 08 19:05:36 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/25 - Blew (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Preload queue cleared Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::ClearQueue Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::stop Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::stPlaybackTimer Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:05:38 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:05:38 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::serviceStop Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::getTrack 4 Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::serviceStop Mar 08 19:05:38 volumio volumio[921]: info: ControllerMpd::stop Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::clearPlayQueue Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::saveQueue Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::volumioPushQueue Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::addQueueItems Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::addQueueItems Mar 08 19:05:38 volumio volumio[921]: info: Preload queue cleared Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/01 - Blew.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/01 - Blew.flac Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::volumioPushQueue Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::saveQueue Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::volumioPlay Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::play index 0 Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::addQueueItems Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::addQueueItems Mar 08 19:05:38 volumio volumio[921]: info: Preload queue cleared Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/02 - Floyd The Barber.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/02 - Floyd The Barber.flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/03 - About A Girl.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/03 - About A Girl.flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/04 - School.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/04 - School.flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/05 - Love Buzz.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/05 - Love Buzz.flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/06 - Paper Cuts.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/06 - Paper Cuts.flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/07 - Negative Creep.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/07 - Negative Creep.flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/08 - Scoff.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/08 - Scoff.flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/09 - Swap Meet.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/09 - Swap Meet.flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/10 - Mr. Moustache.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/10 - Mr. Moustache.flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/11 - Sifting.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/11 - Sifting.flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/12 - Big Cheese.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/12 - Big Cheese.flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/13 - Downer.flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/13 - Downer.flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/24 - Been A Son (Blew EP Version).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/24 - Been A Son (Blew EP Version).flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/14 - Intro (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/14 - Intro (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/15 - School (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/15 - School (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/16 - Floyd The Barber (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/16 - Floyd The Barber (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/17 - Dive (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/17 - Dive (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/18 - Love Buzz (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/18 - Love Buzz (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/19 - Spank Thru (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/19 - Spank Thru (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/20 - Molly's Lips (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/20 - Molly's Lips (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/21 - Sappy (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/21 - Sappy (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/22 - Scoff (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/22 - Scoff (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/23 - About A Girl (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/23 - About A Girl (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/24 - Been A Son (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/24 - Been A Son (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/25 - Blew (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: Using cached record of: music-library/NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/25 - Blew (Live At Pine Street Theatre).flac Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::stop Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::volumioPushQueue Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::saveQueue Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::play index undefined Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::startPlaybackTimer Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::clearAddPlayTracks NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/01 - Blew.flac Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:05:38 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:05:38 volumio volumio[921]: info: Mar 08 19:05:38 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:05:38 volumio volumio[921]: info: sendMpdCommand stop took 22 milliseconds Mar 08 19:05:38 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:05:38 volumio volumio[921]: info: sendMpdCommand stop took 9 milliseconds Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 19:05:38 volumio volumio[921]: info: Mar 08 19:05:38 volumio volumio[921]: ---------------------------- MPD announces system playlist update Mar 08 19:05:38 volumio volumio[921]: info: Ignoring MPD Status Update Mar 08 19:05:38 volumio volumio[921]: info: sendMpdCommand status took 1 milliseconds Mar 08 19:05:38 volumio volumio[921]: info: sendMpdCommand clear took 1 milliseconds Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand add "NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/01 - Blew.flac" Mar 08 19:05:38 volumio volumio[921]: error: updateQueue error: null Mar 08 19:05:38 volumio volumio[921]: info: Mar 08 19:05:38 volumio volumio[921]: ---------------------------- MPD announces system playlist update Mar 08 19:05:38 volumio volumio[921]: info: Ignoring MPD Status Update Mar 08 19:05:38 volumio volumio[921]: info: ------------------------------ 2ms Mar 08 19:05:38 volumio volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 19:05:38 volumio volumio[921]: info: sendMpdCommand add "NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/01 - Blew.flac" took 1 milliseconds Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand play Mar 08 19:05:38 volumio volumio[921]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 08 19:05:38 volumio volumio[921]: info: ------------------------------ 4ms Mar 08 19:05:38 volumio volumio[921]: info: ------------------------------ 3ms Mar 08 19:05:38 volumio volumio[921]: info: sendMpdCommand play took 2 milliseconds Mar 08 19:05:38 volumio volumio[921]: info: Mar 08 19:05:38 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:05:38 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:05:38 volumio volumio[921]: info: Mar 08 19:05:38 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:05:38 volumio volumio[921]: info: sendMpdCommand status took 2 milliseconds Mar 08 19:05:38 volumio volumio[921]: info: ControllerMpd::getState Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand status Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:05:38 volumio volumio[921]: info: sendMpdCommand status took 1 milliseconds Mar 08 19:05:38 volumio volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::parseState Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:05:38 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:05:38 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":174,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Blew","artist":"NIRVANA","album":"\"BLEACH\"","uri":"NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/01 - Blew.flac","trackType":"flac"} Mar 08 19:05:38 volumio volumio[921]: verbose: CURRENT POSITION 0 Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus stop Mar 08 19:05:38 volumio volumio[921]: info: ------------------------------ 5ms Mar 08 19:05:38 volumio volumio[921]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 08 19:05:38 volumio volumio[921]: verbose: ControllerMpd::parseTrackInfo Mar 08 19:05:38 volumio volumio[921]: info: ControllerMpd::pushState Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::servicePushState Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:05:38 volumio volumio[921]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":174,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Blew","artist":"NIRVANA","album":"\"BLEACH\"","uri":"NAS/Volume_1/musica/NIRVANA - 01 - BLEACH (1989)/01 - Blew.flac","trackType":"flac"} Mar 08 19:05:38 volumio volumio[921]: verbose: CURRENT POSITION 0 Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::syncState stateService play Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::syncState currentStatus play Mar 08 19:05:38 volumio volumio[921]: info: Received an update from plugin. extracting info from payload Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:05:38 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:05:38 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:05:38 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:05:38 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:05:38 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:05:38 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:05:38 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:05:38 volumio volumio[921]: info: ------------------------------ 12ms Mar 08 19:05:38 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:05:38 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:05:54 volumio volumio[921]: info: Preload queue cleared Mar 08 19:05:54 volumio volumio[921]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 08 19:05:54 volumio volumio[921]: info: CoreStateMachine::ClearQueue Mar 08 19:05:54 volumio volumio[921]: info: CoreStateMachine::stop Mar 08 19:05:54 volumio volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 19:05:54 volumio volumio[921]: info: CoreStateMachine::stPlaybackTimer Mar 08 19:05:54 volumio volumio[921]: info: CoreStateMachine::updateTrackBlock Mar 08 19:05:54 volumio volumio[921]: info: CorePlayQueue::getTrackBlock Mar 08 19:05:54 volumio volumio[921]: info: CoreStateMachine::pushState Mar 08 19:05:54 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:05:54 volumio volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 19:05:54 volumio volumio[921]: info: CoreCommandRouter::volumioPushState Mar 08 19:05:54 volumio volumio[921]: info: MRS: Pushing multiroomSync output update for this device Mar 08 19:05:54 volumio volumio[921]: info: MRS: Pushing multiroomSync output Mar 08 19:05:54 volumio volumio[921]: info: CoreStateMachine::serviceStop Mar 08 19:05:54 volumio volumio[921]: info: CorePlayQueue::getTrack 0 Mar 08 19:05:54 volumio volumio[921]: info: CoreCommandRouter::serviceStop Mar 08 19:05:54 volumio volumio[921]: info: ControllerMpd::stop Mar 08 19:05:54 volumio volumio[921]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 19:05:54 volumio volumio[921]: info: CorePlayQueue::clearPlayQueue Mar 08 19:05:54 volumio volumio[921]: info: CorePlayQueue::saveQueue Mar 08 19:05:54 volumio volumio[921]: info: CoreCommandRouter::volumioPushQueue Mar 08 19:05:54 volumio volumio[921]: info: CoreStateMachine::addQueueItems Mar 08 19:05:54 volumio volumio[921]: info: CorePlayQueue::addQueueItems Mar 08 19:05:54 volumio volumio[921]: info: Preload queue cleared Mar 08 19:05:54 volumio volumio[921]: info: Adding Item to queue: music-library/NAS/Volume_1/musica Mar 08 19:05:54 volumio volumio[921]: info: Exploding uri music-library/NAS/Volume_1/musica in service mpd Mar 08 19:05:54 volumio volumio[921]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Mar 08 19:05:54 volumio volumio[921]: info: sendMpdCommand stop took 656 milliseconds Mar 08 19:05:54 volumio volumio[921]: info: Mar 08 19:05:54 volumio volumio[921]: ---------------------------- MPD announces state update: player Mar 08 19:05:54 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=AUDIOSLAVE/OUT%20OF%20EXILE/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FAUDIOSLAVE%20-%2002%20-%20OUT%20OF%20EXILE%20(2005).zip&metadata=false Mar 08 19:05:54 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/AUDIOSLAVE - 02 - OUT OF EXILE (2005).zip Mar 08 19:05:54 volumio volumio[921]: info: ALBUMART /albumart?cacheid=199&web=AUDIOSLAVE/OUT%20OF%20EXILE/extralarge&path=%2Fmnt%2FNAS%2FVolume_1%2Fmusica%2FAUDIOSLAVE%20-%2002%20-%20OUT%20OF%20EXILE%20(2005).zip&metadata=false Mar 08 19:05:54 volumio volumio[921]: info: URI /mnt/NAS/Volume_1/musica/AUDIOSLAVE - 02 - OUT OF EXILE (2005).zip Mar 08 19:05:54 volumio volumio[921]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 19:05:54 volumio volumio[921]: Error: Unable to resolve or reject the same promise twice Mar 08 19:05:54 volumio volumio[921]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 08 19:05:54 volumio volumio[921]: at /volumio/app/plugins/music_service/mpd/index.js:2569:21 Mar 08 19:05:54 volumio volumio[921]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Mar 08 19:05:54 volumio volumio[921]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Mar 08 19:05:54 volumio volumio[921]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Mar 08 19:05:54 volumio volumio[921]: at Socket.emit (events.js:315:20) Mar 08 19:05:54 volumio volumio[921]: at addChunk (internal/streams/readable.js:309:12) Mar 08 19:05:54 volumio volumio[921]: at readableAddChunk (internal/streams/readable.js:280:11) Mar 08 19:05:54 volumio volumio[921]: at Socket.Readable.push (internal/streams/readable.js:223:10) Mar 08 19:05:54 volumio volumio[921]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Mar 08 19:05:54 volumio volumio[921]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 19:05:56 volumio sudo[1649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-08 19:04 Mar 08 19:05:56 volumio sudo[1649]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"