Oct 17 12:04:12 rivoplus volumio[3615]: info: Oct 17 12:04:12 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:04:12 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:04:12 rivoplus volumio[3615]: info: Oct 17 12:04:12 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:04:12 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:04:12 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:04:12 rivoplus volumio[3615]: info: Oct 17 12:04:12 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:04:12 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:04:12 rivoplus volumio[3615]: info: Oct 17 12:04:12 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:04:12 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:04:12 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:04:12 rivoplus volumio[3615]: info: Oct 17 12:04:12 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:04:12 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:04:12 rivoplus volumio[3615]: info: Oct 17 12:04:12 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:04:12 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:04:12 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:04:12 rivoplus volumio[3615]: info: ------------------------------ 15ms Oct 17 12:04:12 rivoplus volumio[3615]: info: sendMpdCommand status took 14 milliseconds Oct 17 12:04:12 rivoplus volumio[3615]: info: ------------------------------ 14ms Oct 17 12:04:12 rivoplus volumio[3615]: info: sendMpdCommand status took 13 milliseconds Oct 17 12:04:12 rivoplus volumio[3615]: info: ------------------------------ 6ms Oct 17 12:04:12 rivoplus volumio[3615]: info: sendMpdCommand status took 5 milliseconds Oct 17 12:04:12 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:04:12 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:04:12 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:04:12 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:04:12 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:04:12 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:04:12 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 17 12:04:12 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 17 12:04:12 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 17 12:04:12 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:04:12 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:04:12 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:04:12 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:04:12 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3161271,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Michael Jackson - You Are Not Alone","artist":"Disco Mix","album":null,"uri":"https://play.discomix.ro/8002/stream","trackType":""} Oct 17 12:04:12 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:04:12 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:04:12 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:04:12 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3161271,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Michael Jackson - You Are Not Alone","artist":"Disco Mix","album":null,"uri":"https://play.discomix.ro/8002/stream","trackType":""} Oct 17 12:04:12 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:04:12 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:04:12 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:04:12 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3161271,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Michael Jackson - You Are Not Alone","artist":"Disco Mix","album":null,"uri":"https://play.discomix.ro/8002/stream","trackType":""} Oct 17 12:04:12 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:04:12 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:04:12 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:04:12 rivoplus volumio[3615]: info: ------------------------------ 122ms Oct 17 12:04:12 rivoplus volumio[3615]: info: ------------------------------ 124ms Oct 17 12:04:12 rivoplus volumio[3615]: info: ------------------------------ 130ms Oct 17 12:04:46 rivoplus volumio[3615]: verbose: New Socket.io Connection to 192.168.0.10 from 192.168.0.2 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/27.0.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 7 Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::volumioGetState Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::volumioGetState Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 12:04:46 rivoplus volumio[3615]: info: Received Get System Info Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:04:46 rivoplus volumio[3615]: info: Discovery: Getting this device information Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::volumioGetState Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::volumioGetState Oct 17 12:04:46 rivoplus volumio[3615]: info: Listing playlists Oct 17 12:04:46 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 17 12:04:48 rivoplus volumio[3615]: info: Executing endpoint metavolumio Oct 17 12:04:48 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 17 12:04:48 rivoplus volumio[3615]: info: Executing endpoint metavolumio Oct 17 12:04:48 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 17 12:04:52 rivoplus volumio[3615]: info: CoreCommandRouter::volumioGetQueue Oct 17 12:04:52 rivoplus volumio[3615]: info: CoreStateMachine::getQueue Oct 17 12:04:52 rivoplus volumio[3615]: info: CorePlayQueue::getQueue Oct 17 12:04:54 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 17 12:04:54 rivoplus volumio[3615]: info: CURURI: music-library Oct 17 12:04:55 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:04:56 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 17 12:04:56 rivoplus volumio[3615]: info: CURURI: music-library/USB Oct 17 12:04:56 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:04:57 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 17 12:04:57 rivoplus volumio[3615]: info: CURURI: music-library/USB/X10_Pro Oct 17 12:04:57 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:04:58 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 17 12:04:58 rivoplus volumio[3615]: info: CURURI: music-library/USB/X10_Pro/M Oct 17 12:04:58 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:02 rivoplus volumio[3615]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Oct 17 12:05:02 rivoplus volumio[3615]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Oct 17 12:05:02 rivoplus volumio[3615]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Oct 17 12:05:02 rivoplus volumio[3615]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Oct 17 12:05:02 rivoplus volumio[3615]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Oct 17 12:05:02 rivoplus volumio[3615]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Oct 17 12:05:02 rivoplus volumio[3615]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Oct 17 12:05:02 rivoplus volumio[3615]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 17 12:05:02 rivoplus volumio[3615]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 17 12:05:02 rivoplus volumio[3615]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Oct 17 12:05:02 rivoplus volumio[3615]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Oct 17 12:05:02 rivoplus volumio[3615]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Oct 17 12:05:02 rivoplus volumio[3615]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Oct 17 12:05:02 rivoplus volumio[3615]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Oct 17 12:05:02 rivoplus volumio[3615]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Oct 17 12:05:02 rivoplus volumio[3615]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Oct 17 12:05:02 rivoplus volumio[3615]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 17 12:05:02 rivoplus volumio[3615]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 17 12:05:05 rivoplus volumio[3615]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Oct 17 12:05:05 rivoplus volumio[3615]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Oct 17 12:05:05 rivoplus volumio[3615]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Oct 17 12:05:05 rivoplus volumio[3615]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Oct 17 12:05:05 rivoplus volumio[3615]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Oct 17 12:05:05 rivoplus volumio[3615]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Oct 17 12:05:05 rivoplus volumio[3615]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Oct 17 12:05:05 rivoplus volumio[3615]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 17 12:05:05 rivoplus volumio[3615]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 17 12:05:08 rivoplus volumio[3615]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Oct 17 12:05:08 rivoplus volumio[3615]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Oct 17 12:05:08 rivoplus volumio[3615]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Oct 17 12:05:08 rivoplus volumio[3615]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Oct 17 12:05:08 rivoplus volumio[3615]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Oct 17 12:05:08 rivoplus volumio[3615]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Oct 17 12:05:08 rivoplus volumio[3615]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Oct 17 12:05:08 rivoplus volumio[3615]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 17 12:05:08 rivoplus volumio[3615]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 17 12:05:08 rivoplus volumio[3615]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Oct 17 12:05:08 rivoplus volumio[3615]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Oct 17 12:05:08 rivoplus volumio[3615]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Oct 17 12:05:08 rivoplus volumio[3615]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Oct 17 12:05:08 rivoplus volumio[3615]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Oct 17 12:05:08 rivoplus volumio[3615]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Oct 17 12:05:08 rivoplus volumio[3615]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Oct 17 12:05:08 rivoplus volumio[3615]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 17 12:05:08 rivoplus volumio[3615]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 17 12:05:09 rivoplus volumio[3615]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Oct 17 12:05:09 rivoplus volumio[3615]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Oct 17 12:05:09 rivoplus volumio[3615]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Oct 17 12:05:09 rivoplus volumio[3615]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Oct 17 12:05:09 rivoplus volumio[3615]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Oct 17 12:05:09 rivoplus volumio[3615]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Oct 17 12:05:09 rivoplus volumio[3615]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Oct 17 12:05:09 rivoplus volumio[3615]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 17 12:05:09 rivoplus volumio[3615]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 17 12:05:09 rivoplus volumio[3615]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Oct 17 12:05:09 rivoplus volumio[3615]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Oct 17 12:05:09 rivoplus volumio[3615]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Oct 17 12:05:09 rivoplus volumio[3615]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Oct 17 12:05:09 rivoplus volumio[3615]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Oct 17 12:05:09 rivoplus volumio[3615]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Oct 17 12:05:09 rivoplus volumio[3615]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Oct 17 12:05:09 rivoplus volumio[3615]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 17 12:05:09 rivoplus volumio[3615]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 17 12:05:09 rivoplus volumio[3615]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Oct 17 12:05:09 rivoplus volumio[3615]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Oct 17 12:05:09 rivoplus volumio[3615]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Oct 17 12:05:09 rivoplus volumio[3615]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Oct 17 12:05:09 rivoplus volumio[3615]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Oct 17 12:05:09 rivoplus volumio[3615]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Oct 17 12:05:09 rivoplus volumio[3615]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Oct 17 12:05:09 rivoplus volumio[3615]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 17 12:05:09 rivoplus volumio[3615]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 17 12:05:14 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 17 12:05:14 rivoplus volumio[3615]: info: CURURI: music-library/USB/X10_Pro/M/Sade Oct 17 12:05:14 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:17 rivoplus volumio[3615]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found Oct 17 12:05:17 rivoplus volumio[3615]: at createHttpError (/volumio/node_modules/send/index.js:979:12) Oct 17 12:05:17 rivoplus volumio[3615]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) Oct 17 12:05:17 rivoplus volumio[3615]: at SendStream.pipe (/volumio/node_modules/send/index.js:580:14) Oct 17 12:05:17 rivoplus volumio[3615]: at sendfile (/volumio/node_modules/express/lib/response.js:1139:8) Oct 17 12:05:17 rivoplus volumio[3615]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:450:3) Oct 17 12:05:17 rivoplus volumio[3615]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) Oct 17 12:05:17 rivoplus volumio[3615]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 17 12:05:17 rivoplus volumio[3615]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 17 12:05:20 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 17 12:05:20 rivoplus volumio[3615]: info: CURURI: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan) Oct 17 12:05:21 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:23 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 17 12:05:23 rivoplus volumio[3615]: info: CURURI: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1 Oct 17 12:05:23 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/03 Sade - Hang On to Your Love.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/04 Sade - The Sweetest Taboo.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/05 Sade - Is It a Crime.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/06 Sade - Never As Good As the First Time.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/07 Sade - Jezebel.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/08 Sade - Love Is Stronger Than Pride.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/09 Sade - Paradise.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/10 Sade - Nothing Can Come between Us.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/11 Sade - No Ordinary Love.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/12 Sade - Kiss of Life.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/13 Sade - Feel No Pain.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Preloading song: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/14 Sade - Bullet Proof Soul.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F01%20Sade%20-%20Your%20Love%20Is%20King.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F02%20Sade%20-%20Smooth%20Operator.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/03 Sade - Hang On to Your Love.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F03%20Sade%20-%20Hang%20On%20to%20Your%20Love.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/03 Sade - Hang On to Your Love.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/04 Sade - The Sweetest Taboo.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F04%20Sade%20-%20The%20Sweetest%20Taboo.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/04 Sade - The Sweetest Taboo.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/05 Sade - Is It a Crime.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F05%20Sade%20-%20Is%20It%20a%20Crime.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/05 Sade - Is It a Crime.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/06 Sade - Never As Good As the First Time.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F06%20Sade%20-%20Never%20As%20Good%20As%20the%20First%20Time.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/06 Sade - Never As Good As the First Time.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/07 Sade - Jezebel.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F07%20Sade%20-%20Jezebel.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/07 Sade - Jezebel.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/08 Sade - Love Is Stronger Than Pride.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F08%20Sade%20-%20Love%20Is%20Stronger%20Than%20Pride.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/08 Sade - Love Is Stronger Than Pride.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/09 Sade - Paradise.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F09%20Sade%20-%20Paradise.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/09 Sade - Paradise.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/10 Sade - Nothing Can Come between Us.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F10%20Sade%20-%20Nothing%20Can%20Come%20between%20Us.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/10 Sade - Nothing Can Come between Us.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/11 Sade - No Ordinary Love.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F11%20Sade%20-%20No%20Ordinary%20Love.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/11 Sade - No Ordinary Love.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/12 Sade - Kiss of Life.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F12%20Sade%20-%20Kiss%20of%20Life.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/12 Sade - Kiss of Life.flac Oct 17 12:05:23 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/13 Sade - Feel No Pain.flac in service mpd Oct 17 12:05:23 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F13%20Sade%20-%20Feel%20No%20Pain.flac&metadata=false Oct 17 12:05:23 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/13 Sade - Feel No Pain.flac Oct 17 12:05:24 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/14 Sade - Bullet Proof Soul.flac in service mpd Oct 17 12:05:24 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F14%20Sade%20-%20Bullet%20Proof%20Soul.flac&metadata=false Oct 17 12:05:24 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/14 Sade - Bullet Proof Soul.flac Oct 17 12:05:24 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:24 rivoplus volumio[3615]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 17 12:05:24 rivoplus volumio[3615]: info: CoreStateMachine::ClearQueue Oct 17 12:05:24 rivoplus volumio[3615]: info: CoreStateMachine::stop Oct 17 12:05:24 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:24 rivoplus volumio[3615]: info: CoreStateMachine::stPlaybackTimer Oct 17 12:05:24 rivoplus volumio[3615]: info: CoreStateMachine::updateTrackBlock Oct 17 12:05:24 rivoplus volumio[3615]: info: CorePlayQueue::getTrackBlock Oct 17 12:05:24 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:24 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:24 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:05:24 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:25 rivoplus volumio[3615]: info: CoreStateMachine::serviceStop Oct 17 12:05:25 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:25 rivoplus volumio[3615]: info: CoreCommandRouter::serviceStop Oct 17 12:05:25 rivoplus volumio[3615]: info: [1792227925011] ControllerWebradio::stop Oct 17 12:05:25 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 12:05:25 rivoplus volumio[3615]: info: CorePlayQueue::clearPlayQueue Oct 17 12:05:25 rivoplus volumio[3615]: info: CorePlayQueue::saveQueue Oct 17 12:05:25 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushQueue Oct 17 12:05:25 rivoplus volumio[3615]: info: CoreStateMachine::addQueueItems Oct 17 12:05:25 rivoplus volumio[3615]: info: CorePlayQueue::addQueueItems Oct 17 12:05:25 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushQueue Oct 17 12:05:25 rivoplus volumio[3615]: info: CorePlayQueue::saveQueue Oct 17 12:05:25 rivoplus volumio[3615]: info: CoreStateMachine::updateTrackBlock Oct 17 12:05:25 rivoplus volumio[3615]: info: CorePlayQueue::getTrackBlock Oct 17 12:05:25 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPlay Oct 17 12:05:25 rivoplus volumio[3615]: info: CoreStateMachine::play index 0 Oct 17 12:05:25 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:25 rivoplus volumio[3615]: info: CoreStateMachine::addQueueItems Oct 17 12:05:25 rivoplus volumio[3615]: info: CorePlayQueue::addQueueItems Oct 17 12:05:25 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/03 Sade - Hang On to Your Love.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/03 Sade - Hang On to Your Love.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/04 Sade - The Sweetest Taboo.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/04 Sade - The Sweetest Taboo.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/05 Sade - Is It a Crime.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/05 Sade - Is It a Crime.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/06 Sade - Never As Good As the First Time.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/06 Sade - Never As Good As the First Time.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/07 Sade - Jezebel.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/07 Sade - Jezebel.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/08 Sade - Love Is Stronger Than Pride.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/08 Sade - Love Is Stronger Than Pride.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/09 Sade - Paradise.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/09 Sade - Paradise.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/10 Sade - Nothing Can Come between Us.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/10 Sade - Nothing Can Come between Us.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/11 Sade - No Ordinary Love.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/11 Sade - No Ordinary Love.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/12 Sade - Kiss of Life.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/12 Sade - Kiss of Life.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/13 Sade - Feel No Pain.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/13 Sade - Feel No Pain.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/14 Sade - Bullet Proof Soul.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/14 Sade - Bullet Proof Soul.flac Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:25 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:25 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:25 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:25 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:25 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:26 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:26 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:26 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:26 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:26 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:26 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:26 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:26 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:26 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:26 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:26 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:26 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:27 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:27 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:27 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:27 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:27 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:27 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:27 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:27 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:27 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:27 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:27 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:27 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue in service mpd Oct 17 12:05:27 rivoplus volumio[3615]: info: CoreStateMachine::stop Oct 17 12:05:27 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:27 rivoplus volumio[3615]: info: CoreStateMachine::play index undefined Oct 17 12:05:27 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:27 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:27 rivoplus volumio[3615]: info: CoreStateMachine::startPlaybackTimer Oct 17 12:05:27 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:27 rivoplus volumio[3615]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 12:05:27 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 12:05:27 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::clearAddPlayTracks USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushQueue Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::saveQueue Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::updateTrackBlock Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrackBlock Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand stop took 3077 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand stop took 87 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand clear Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 12:05:28 rivoplus volumio[3615]: info: Received Get System Info Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 12:05:28 rivoplus volumio[3615]: info: Discovery: Getting this device information Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioGetState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:28 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand status took 30 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand clear took 29 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand status took 28 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand status took 27 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand add "USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac" Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 17 12:05:28 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService stop Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:28 rivoplus volumio[3615]: info: No code Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 17 12:05:28 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService stop Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:28 rivoplus volumio[3615]: info: No code Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 121ms Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 122ms Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:28 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:28 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:28 rivoplus volumio[3615]: Upnp client error: Error: This socket has been ended by the other party Oct 17 12:05:28 rivoplus volumio[3615]: error: updateQueue error: null Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:28 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 112ms Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 108 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand add "USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac" took 108 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 15ms Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 13ms Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand play Oct 17 12:05:28 rivoplus volumio[3615]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 146ms Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:28 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:28 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:28 rivoplus kernel: usb 1-1.4.3: uac_clock_source_is_valid(): cannot get clock validity for id 5 Oct 17 12:05:28 rivoplus kernel: usb 1-1.4.3: clock source 5 is not valid, cannot use Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 77ms Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand play took 73 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 73ms Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 72ms Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:28 rivoplus volumio[3615]: info: MCU Signalled Playback Inactive Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:28 rivoplus volumio[3615]: error: MPD returned error for command status: Failed to open "alsa" (alsa); Error opening ALSA device "volumio"; snd_pcm_hw_params() failed: No such device or address Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand status took 45 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: error: MPD returned error for command status: Failed to open "alsa" (alsa); Error opening ALSA device "volumio"; snd_pcm_hw_params() failed: No such device or address Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand status took 45 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: error: MPD returned error for command status: Failed to open "alsa" (alsa); Error opening ALSA device "volumio"; snd_pcm_hw_params() failed: No such device or address Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand status took 44 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:28 rivoplus volumio[3615]: info: Oct 17 12:05:28 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:28 rivoplus volumio[3615]: error: MPD returned error for command status: Failed to open "alsa" (alsa); Error opening ALSA device "volumio"; snd_pcm_hw_params() failed: No such device or address Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand status took 119 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand clearerror took 94 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand clearerror took 94 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand clearerror took 95 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 71 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 70 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 70 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand status took 54 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand status took 53 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Your Love Is King","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac","trackType":"flac"} Oct 17 12:05:28 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService pause Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Your Love Is King","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac","trackType":"flac"} Oct 17 12:05:28 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService pause Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Your Love Is King","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac","trackType":"flac"} Oct 17 12:05:28 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService pause Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 227ms Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 220ms Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 218ms Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand clearerror took 129 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 117 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 114 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 114 milliseconds Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:28 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Your Love Is King","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac","trackType":"flac"} Oct 17 12:05:28 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService pause Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Your Love Is King","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac","trackType":"flac"} Oct 17 12:05:28 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService pause Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:28 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Your Love Is King","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac","trackType":"flac"} Oct 17 12:05:28 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService pause Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:28 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 303ms Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 241ms Oct 17 12:05:28 rivoplus volumio[3615]: info: ------------------------------ 227ms Oct 17 12:05:28 rivoplus volumio[3615]: info: Executing endpoint metavolumio Oct 17 12:05:28 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 17 12:05:30 rivoplus volumio[3615]: info: Executing endpoint metavolumio Oct 17 12:05:30 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 17 12:05:30 rivoplus volumio[3615]: info: Executing endpoint metavolumio Oct 17 12:05:30 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 17 12:05:30 rivoplus volumio[3615]: info: Executing endpoint metavolumio Oct 17 12:05:30 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 17 12:05:31 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::ClearQueue Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::stop Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::clearPlayQueue Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::saveQueue Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushQueue Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::addQueueItems Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::addQueueItems Oct 17 12:05:31 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushQueue Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::saveQueue Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::updateTrackBlock Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::getTrackBlock Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPlay Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::play index 1 Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::addQueueItems Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::addQueueItems Oct 17 12:05:31 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/03 Sade - Hang On to Your Love.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/03 Sade - Hang On to Your Love.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/04 Sade - The Sweetest Taboo.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/04 Sade - The Sweetest Taboo.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/05 Sade - Is It a Crime.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/05 Sade - Is It a Crime.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/06 Sade - Never As Good As the First Time.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/06 Sade - Never As Good As the First Time.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/07 Sade - Jezebel.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/07 Sade - Jezebel.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/08 Sade - Love Is Stronger Than Pride.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/08 Sade - Love Is Stronger Than Pride.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/09 Sade - Paradise.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/09 Sade - Paradise.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/10 Sade - Nothing Can Come between Us.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/10 Sade - Nothing Can Come between Us.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/11 Sade - No Ordinary Love.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/11 Sade - No Ordinary Love.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/12 Sade - Kiss of Life.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/12 Sade - Kiss of Life.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/13 Sade - Feel No Pain.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/13 Sade - Feel No Pain.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/14 Sade - Bullet Proof Soul.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/14 Sade - Bullet Proof Soul.flac Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::stop Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushQueue Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::saveQueue Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::play index undefined Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::updateTrackBlock Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::getTrackBlock Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::startPlaybackTimer Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::clearAddPlayTracks USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 12:05:31 rivoplus volumio[3615]: info: Oct 17 12:05:31 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:31 rivoplus volumio[3615]: info: sendMpdCommand stop took 35 milliseconds Oct 17 12:05:31 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand clear Oct 17 12:05:31 rivoplus volumio[3615]: info: Oct 17 12:05:31 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:31 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:31 rivoplus volumio[3615]: info: Oct 17 12:05:31 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:31 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:31 rivoplus volumio[3615]: info: Oct 17 12:05:31 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:31 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:31 rivoplus volumio[3615]: info: sendMpdCommand status took 6 milliseconds Oct 17 12:05:31 rivoplus volumio[3615]: info: sendMpdCommand clear took 6 milliseconds Oct 17 12:05:31 rivoplus volumio[3615]: info: sendMpdCommand status took 5 milliseconds Oct 17 12:05:31 rivoplus volumio[3615]: info: sendMpdCommand status took 3 milliseconds Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand add "USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac" Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:31 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:31 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 17 12:05:31 rivoplus volumio[3615]: verbose: CURRENT POSITION 1 Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService stop Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:31 rivoplus volumio[3615]: info: No code Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:31 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:31 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 17 12:05:31 rivoplus volumio[3615]: verbose: CURRENT POSITION 1 Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService stop Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:31 rivoplus volumio[3615]: info: No code Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:31 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:31 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:31 rivoplus volumio[3615]: info: ------------------------------ 103ms Oct 17 12:05:31 rivoplus volumio[3615]: info: ------------------------------ 103ms Oct 17 12:05:31 rivoplus volumio[3615]: info: Oct 17 12:05:31 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:31 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:31 rivoplus volumio[3615]: info: Oct 17 12:05:31 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:31 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:31 rivoplus volumio[3615]: error: updateQueue error: null Oct 17 12:05:31 rivoplus volumio[3615]: info: Oct 17 12:05:31 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:31 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:31 rivoplus volumio[3615]: info: ------------------------------ 114ms Oct 17 12:05:31 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 111 milliseconds Oct 17 12:05:31 rivoplus volumio[3615]: info: sendMpdCommand add "USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac" took 112 milliseconds Oct 17 12:05:31 rivoplus volumio[3615]: info: ------------------------------ 13ms Oct 17 12:05:31 rivoplus volumio[3615]: info: ------------------------------ 11ms Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:31 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand play Oct 17 12:05:31 rivoplus volumio[3615]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Oct 17 12:05:31 rivoplus volumio[3615]: info: ------------------------------ 124ms Oct 17 12:05:31 rivoplus volumio[3615]: info: Oct 17 12:05:31 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:31 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:31 rivoplus volumio[3615]: info: Oct 17 12:05:31 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:31 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:31 rivoplus volumio[3615]: info: Oct 17 12:05:31 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:31 rivoplus volumio[3615]: info: ------------------------------ 87ms Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand play took 83 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: info: ------------------------------ 82ms Oct 17 12:05:32 rivoplus volumio[3615]: info: ------------------------------ 81ms Oct 17 12:05:32 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:32 rivoplus volumio[3615]: info: Oct 17 12:05:32 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:32 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:32 rivoplus volumio[3615]: info: Oct 17 12:05:32 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:32 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:32 rivoplus volumio[3615]: info: Oct 17 12:05:32 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:32 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand status took 7 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand status took 6 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand status took 4 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:32 rivoplus volumio[3615]: info: Oct 17 12:05:32 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:32 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand status took 9 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand status took 4 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:32 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"888 Kbps","isStreaming":false,"title":"Smooth Operator","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac","trackType":"flac"} Oct 17 12:05:32 rivoplus volumio[3615]: verbose: CURRENT POSITION 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:32 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"888 Kbps","isStreaming":false,"title":"Smooth Operator","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac","trackType":"flac"} Oct 17 12:05:32 rivoplus volumio[3615]: verbose: CURRENT POSITION 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:05:32 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:32 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"888 Kbps","isStreaming":false,"title":"Smooth Operator","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac","trackType":"flac"} Oct 17 12:05:32 rivoplus volumio[3615]: verbose: CURRENT POSITION 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:05:32 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:32 rivoplus volumio[3615]: info: ------------------------------ 69ms Oct 17 12:05:32 rivoplus volumio[3615]: info: ------------------------------ 125ms Oct 17 12:05:32 rivoplus volumio[3615]: info: ------------------------------ 124ms Oct 17 12:05:32 rivoplus volumio[3615]: info: Oct 17 12:05:32 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:32 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 112 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 111 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand status took 3 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:32 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"888 Kbps","isStreaming":false,"title":"Smooth Operator","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac","trackType":"flac"} Oct 17 12:05:32 rivoplus volumio[3615]: verbose: CURRENT POSITION 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:05:32 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:32 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"888 Kbps","isStreaming":false,"title":"Smooth Operator","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac","trackType":"flac"} Oct 17 12:05:32 rivoplus volumio[3615]: verbose: CURRENT POSITION 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:05:32 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:32 rivoplus volumio[3615]: info: ------------------------------ 217ms Oct 17 12:05:32 rivoplus volumio[3615]: info: ------------------------------ 211ms Oct 17 12:05:32 rivoplus volumio[3615]: info: Signalling Playback active due to playback status change Oct 17 12:05:32 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 172 milliseconds Oct 17 12:05:32 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:32 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1100,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"775 Kbps","isStreaming":false,"title":"Smooth Operator","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac","trackType":"flac"} Oct 17 12:05:32 rivoplus volumio[3615]: verbose: CURRENT POSITION 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:05:32 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:32 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:32 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:32 rivoplus volumio[3615]: info: ------------------------------ 217ms Oct 17 12:05:32 rivoplus volumio[3615]: info: MCU Signalled Playback Active Oct 17 12:05:34 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::ClearQueue Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::stop Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::stPlaybackTimer Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::updateTrackBlock Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrackBlock Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::serviceStop Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 1 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::serviceStop Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::stop Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::clearPlayQueue Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::saveQueue Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushQueue Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::addQueueItems Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::addQueueItems Oct 17 12:05:34 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushQueue Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::saveQueue Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::updateTrackBlock Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrackBlock Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPlay Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::play index 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::addQueueItems Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::addQueueItems Oct 17 12:05:34 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/03 Sade - Hang On to Your Love.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/03 Sade - Hang On to Your Love.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/04 Sade - The Sweetest Taboo.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/04 Sade - The Sweetest Taboo.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/05 Sade - Is It a Crime.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/05 Sade - Is It a Crime.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/06 Sade - Never As Good As the First Time.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/06 Sade - Never As Good As the First Time.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/07 Sade - Jezebel.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/07 Sade - Jezebel.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/08 Sade - Love Is Stronger Than Pride.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/08 Sade - Love Is Stronger Than Pride.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/09 Sade - Paradise.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/09 Sade - Paradise.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/10 Sade - Nothing Can Come between Us.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/10 Sade - Nothing Can Come between Us.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/11 Sade - No Ordinary Love.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/11 Sade - No Ordinary Love.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/12 Sade - Kiss of Life.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/12 Sade - Kiss of Life.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/13 Sade - Feel No Pain.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/13 Sade - Feel No Pain.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/14 Sade - Bullet Proof Soul.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/14 Sade - Bullet Proof Soul.flac Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: Using cached record of: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::stop Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushQueue Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::saveQueue Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::play index undefined Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::updateTrackBlock Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrackBlock Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::startPlaybackTimer Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::clearAddPlayTracks USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand stop took 118 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand stop took 39 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand clear Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:34 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand status took 5 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand clear took 6 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand status took 4 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand status took 3 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand add "USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac" Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 17 12:05:34 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService stop Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: No code Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 17 12:05:34 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService stop Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: No code Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 84ms Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 84ms Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:34 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:34 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:34 rivoplus volumio[3615]: error: updateQueue error: null Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:34 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 94ms Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 93 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand add "USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac" took 92 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 12ms Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 10ms Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand play Oct 17 12:05:34 rivoplus volumio[3615]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 103ms Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:34 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces system playlist update Oct 17 12:05:34 rivoplus volumio[3615]: info: Ignoring MPD Status Update Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 51ms Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand play took 47 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 46ms Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 43ms Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:34 rivoplus volumio[3615]: info: MCU Signalled Playback Inactive Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand status took 16 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand status took 15 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand status took 8 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:34 rivoplus volumio[3615]: info: Oct 17 12:05:34 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand status took 13 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand status took 7 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand status took 5 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseState Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1127 Kbps","isStreaming":false,"title":"Your Love Is King","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac","trackType":"flac"} Oct 17 12:05:34 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1127 Kbps","isStreaming":false,"title":"Your Love Is King","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac","trackType":"flac"} Oct 17 12:05:34 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:05:34 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1127 Kbps","isStreaming":false,"title":"Your Love Is King","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac","trackType":"flac"} Oct 17 12:05:34 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:05:34 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 58ms Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 65ms Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 59ms Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 37 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 35 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: info: sendMpdCommand playlistinfo took 35 milliseconds Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:34 rivoplus volumio[3615]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1127 Kbps","isStreaming":false,"title":"Your Love Is King","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac","trackType":"flac"} Oct 17 12:05:34 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:05:34 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1127 Kbps","isStreaming":false,"title":"Your Love Is King","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac","trackType":"flac"} Oct 17 12:05:34 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:05:34 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: ControllerMpd::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::servicePushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":222,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1127 Kbps","isStreaming":false,"title":"Your Love Is King","artist":"Sade","album":"The Ultimate Collection (Disc 1)","uri":"USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac","trackType":"flac"} Oct 17 12:05:34 rivoplus volumio[3615]: verbose: CURRENT POSITION 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState stateService play Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:05:34 rivoplus volumio[3615]: info: Received an update from plugin. extracting info from payload Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:34 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:34 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 105ms Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 98ms Oct 17 12:05:34 rivoplus volumio[3615]: info: ------------------------------ 97ms Oct 17 12:05:34 rivoplus volumio[3615]: info: Signalling Playback active due to playback status change Oct 17 12:05:34 rivoplus volumio[3615]: info: MCU Signalled Playback Active Oct 17 12:05:43 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreStateMachine::ClearQueue Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreStateMachine::stop Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreStateMachine::stPlaybackTimer Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreStateMachine::updateTrackBlock Oct 17 12:05:43 rivoplus volumio[3615]: info: CorePlayQueue::getTrackBlock Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreStateMachine::pushState Oct 17 12:05:43 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushState Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreStateMachine::serviceStop Oct 17 12:05:43 rivoplus volumio[3615]: info: CorePlayQueue::getTrack 0 Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreCommandRouter::serviceStop Oct 17 12:05:43 rivoplus volumio[3615]: info: ControllerMpd::stop Oct 17 12:05:43 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 12:05:43 rivoplus volumio[3615]: info: CorePlayQueue::clearPlayQueue Oct 17 12:05:43 rivoplus volumio[3615]: info: CorePlayQueue::saveQueue Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreCommandRouter::volumioPushQueue Oct 17 12:05:43 rivoplus volumio[3615]: info: CoreStateMachine::addQueueItems Oct 17 12:05:43 rivoplus volumio[3615]: info: CorePlayQueue::addQueueItems Oct 17 12:05:43 rivoplus volumio[3615]: info: Preload queue cleared Oct 17 12:05:43 rivoplus volumio[3615]: info: Adding Item to queue: music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1 Oct 17 12:05:43 rivoplus volumio[3615]: info: Exploding uri music-library/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1 in service mpd Oct 17 12:05:43 rivoplus volumio[3615]: info: sendMpdCommand stop took 39 milliseconds Oct 17 12:05:43 rivoplus volumio[3615]: info: Oct 17 12:05:43 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:43 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:43 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:43 rivoplus volumio[3615]: info: Oct 17 12:05:43 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:43 rivoplus volumio[3615]: info: ControllerMpd::getState Oct 17 12:05:43 rivoplus volumio[3615]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:05:43 rivoplus volumio[3615]: info: Oct 17 12:05:43 rivoplus volumio[3615]: ---------------------------- MPD announces state update: player Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F01%20Sade%20-%20Your%20Love%20Is%20King.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/01 Sade - Your Love Is King.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F02%20Sade%20-%20Smooth%20Operator.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/02 Sade - Smooth Operator.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F03%20Sade%20-%20Hang%20On%20to%20Your%20Love.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/03 Sade - Hang On to Your Love.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F04%20Sade%20-%20The%20Sweetest%20Taboo.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/04 Sade - The Sweetest Taboo.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F05%20Sade%20-%20Is%20It%20a%20Crime.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/05 Sade - Is It a Crime.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F06%20Sade%20-%20Never%20As%20Good%20As%20the%20First%20Time.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/06 Sade - Never As Good As the First Time.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F07%20Sade%20-%20Jezebel.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/07 Sade - Jezebel.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F08%20Sade%20-%20Love%20Is%20Stronger%20Than%20Pride.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/08 Sade - Love Is Stronger Than Pride.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F09%20Sade%20-%20Paradise.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/09 Sade - Paradise.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F10%20Sade%20-%20Nothing%20Can%20Come%20between%20Us.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/10 Sade - Nothing Can Come between Us.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F11%20Sade%20-%20No%20Ordinary%20Love.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/11 Sade - No Ordinary Love.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F12%20Sade%20-%20Kiss%20of%20Life.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/12 Sade - Kiss of Life.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F13%20Sade%20-%20Feel%20No%20Pain.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/13 Sade - Feel No Pain.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2F14%20Sade%20-%20Bullet%20Proof%20Soul.flac&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/14 Sade - Bullet Proof Soul.flac Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2FSade%20-%20The%20Ultimate%20Collection%20(Disc%201).cue&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:43 rivoplus volumio[3615]: info: ALBUMART /albumart?cacheid=228&web=Sade/The%20Ultimate%20Collection%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FX10_Pro%2FM%2FSade%2FSade%20-%20The%20Ultimate%20Collection%20-%202011%20(Japan)%2FSade%20-%20The%20Ultimate%20Collection%20%20(2011%20Japan)CD1%2FSade%20-%20The%20Ultimate%20Collection%20(Disc%201).cue&metadata=false Oct 17 12:05:43 rivoplus volumio[3615]: info: URI /mnt/USB/X10_Pro/M/Sade/Sade - The Ultimate Collection - 2011 (Japan)/Sade - The Ultimate Collection (2011 Japan)CD1/Sade - The Ultimate Collection (Disc 1).cue Oct 17 12:05:43 rivoplus volumio[3615]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 12:05:43 rivoplus volumio[3615]: Error: Unable to resolve or reject the same promise twice Oct 17 12:05:43 rivoplus volumio[3615]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 17 12:05:43 rivoplus volumio[3615]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Oct 17 12:05:43 rivoplus volumio[3615]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 17 12:05:43 rivoplus volumio[3615]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 17 12:05:43 rivoplus volumio[3615]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 17 12:05:43 rivoplus volumio[3615]: at Socket.emit (node:events:514:28) Oct 17 12:05:43 rivoplus volumio[3615]: at addChunk (node:internal/streams/readable:343:12) Oct 17 12:05:43 rivoplus volumio[3615]: at readableAddChunk (node:internal/streams/readable:312:11) Oct 17 12:05:43 rivoplus volumio[3615]: at Readable.push (node:internal/streams/readable:253:10) Oct 17 12:05:43 rivoplus volumio[3615]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 17 12:05:43 rivoplus volumio[3615]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 12:05:44 rivoplus sudo[17377]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-17 12:04' Oct 17 12:05:44 rivoplus sudo[17377]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="8ed05bf20f96eb8557ed5652c420f84f39d66325" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0a52c1fb90959ba1872a2fb0225e56fe615b19ac" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 16 16:52:40 UTC 2026" VOLUMIO_VERSION="4.208" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="ba37532a86808e19439a6278b2d45f47"