-- Logs begin at Mon 2024-07-22 06:24:14 UTC, end at Mon 2024-07-22 07:33:44 UTC. -- Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 22 07:32:00 opera volumio[1397]: info: Retrieving Cloud Streaming UI Jul 22 07:32:00 opera volumio[1397]: info: Getting Tidal Cloud Configuration Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 22 07:32:00 opera volumio[1397]: info: Getting Qobuz Cloud Configuration Jul 22 07:32:00 opera volumio[1397]: info: Asking plugin for UI Config Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 22 07:32:00 opera volumio[1397]: info: Getting Spotify Cloud Configuration Jul 22 07:32:00 opera volumio[1397]: info: Asking plugin for UI Config Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 22 07:32:00 opera volumio[1397]: error: Could not retrieve plugin music_service spotify Jul 22 07:32:00 opera volumio[1397]: info: Saving Spotify Acccount Jul 22 07:32:00 opera volumio[1397]: info: Got it Jul 22 07:32:00 opera volumio[1397]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 22 07:32:00 opera volumio[1397]: info: Got Tidal Cloud Configuration Jul 22 07:32:00 opera volumio[1397]: info: Got it Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 07:32:00 opera volumio[1397]: info: CoreCommandRouter::volumioGetBrowseSources Jul 22 07:32:01 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 22 07:32:01 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 22 07:32:05 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 22 07:32:06 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jul 22 07:32:06 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand rescan Jul 22 07:32:06 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:32:06 opera volumio[1397]: info: Jul 22 07:32:06 opera volumio[1397]: ---------------------------- MPD announces state update: update Jul 22 07:32:06 opera volumio[1397]: info: sendMpdCommand rescan took 4 milliseconds Jul 22 07:32:06 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:32:06 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:32:06 opera volumio[1397]: info: sendMpdCommand status took 3 milliseconds Jul 22 07:32:06 opera volumio[1397]: info: sendMpdCommand status took 1 milliseconds Jul 22 07:32:06 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:32:06 opera volumio[1397]: info: Command Router : Notfying DB Updatetrue Jul 22 07:32:06 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:32:06 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:32:06 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:32:06 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:06 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:06 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:06 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:06 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:06 opera volumio[1397]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 22 07:32:06 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:32:06 opera volumio[1397]: info: CoreStateMachine::syncState stateService stop Jul 22 07:32:06 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus stop Jul 22 07:32:06 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:06 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:06 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:06 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:06 opera volumio[1397]: info: No code Jul 22 07:32:06 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:06 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:06 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:06 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:06 opera volumio[1397]: info: ------------------------------ 52ms Jul 22 07:32:06 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:06 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:06 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:08 opera volumio[1397]: info: CoreCommandRouter::Close All Modals sent Jul 22 07:32:09 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 22 07:32:13 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 22 07:32:17 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 22 07:32:21 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 22 07:32:21 opera volumio[1397]: info: MPD Database updated - AlbumList cache refreshed Jul 22 07:32:21 opera volumio[1397]: info: Jul 22 07:32:21 opera volumio[1397]: ---------------------------- MPD announces state update: database Jul 22 07:32:21 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:32:21 opera volumio[1397]: info: Jul 22 07:32:21 opera volumio[1397]: ---------------------------- MPD announces state update: update Jul 22 07:32:21 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:32:21 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:32:21 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:32:21 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:32:22 opera volumio[1397]: info: sendMpdCommand status took 436 milliseconds Jul 22 07:32:22 opera volumio[1397]: info: sendMpdCommand status took 435 milliseconds Jul 22 07:32:22 opera volumio[1397]: info: sendMpdCommand status took 436 milliseconds Jul 22 07:32:22 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:32:22 opera volumio[1397]: info: Command Router : Notfying DB Updatefalse Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::Close All Modals sent Jul 22 07:32:22 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:32:22 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:32:22 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:32:22 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:22 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:22 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:22 opera volumio[1397]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 22 07:32:22 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:32:22 opera volumio[1397]: info: CoreStateMachine::syncState stateService stop Jul 22 07:32:22 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus stop Jul 22 07:32:22 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:22 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:22 opera volumio[1397]: info: No code Jul 22 07:32:22 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:22 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:22 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:32:22 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:22 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:22 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:22 opera volumio[1397]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 22 07:32:22 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:32:22 opera volumio[1397]: info: CoreStateMachine::syncState stateService stop Jul 22 07:32:22 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus stop Jul 22 07:32:22 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:22 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:22 opera volumio[1397]: info: No code Jul 22 07:32:22 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:22 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:22 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:22 opera volumio[1397]: info: ------------------------------ 499ms Jul 22 07:32:22 opera volumio[1397]: info: ------------------------------ 499ms Jul 22 07:32:22 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:22 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:22 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:22 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:22 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:22 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:25 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 22 07:32:27 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 22 07:32:27 opera volumio[1397]: info: CURURI: music-library Jul 22 07:32:28 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 22 07:32:28 opera volumio[1397]: info: CURURI: music-library/USB Jul 22 07:32:29 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 22 07:32:29 opera volumio[1397]: info: CURURI: music-library/USB/DSD...600 Jul 22 07:32:36 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 22 07:32:36 opera volumio[1397]: info: CURURI: music-library/USB/DSD...600/1..DSD Jul 22 07:32:42 opera volumio[1397]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 22 07:32:42 opera volumio[1397]: info: CoreStateMachine::ClearQueue Jul 22 07:32:42 opera volumio[1397]: info: CoreStateMachine::stop Jul 22 07:32:42 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:32:42 opera volumio[1397]: verbose: UNSET VOLATILE Jul 22 07:32:42 opera volumio[1397]: info: CorePlayQueue::clearPlayQueue Jul 22 07:32:42 opera volumio[1397]: info: CorePlayQueue::saveQueue Jul 22 07:32:42 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:42 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:42 opera volumio[1397]: info: CoreCommandRouter::volumioPushQueue Jul 22 07:32:42 opera volumio[1397]: info: CoreStateMachine::addQueueItems Jul 22 07:32:42 opera volumio[1397]: info: CorePlayQueue::addQueueItems Jul 22 07:32:42 opera volumio[1397]: info: Adding Item to queue: music-library/USB/DSD...600/1..DSD/Autumn Yearning Jul 22 07:32:42 opera volumio[1397]: info: Exploding uri music-library/USB/DSD...600/1..DSD/Autumn Yearning in service mpd Jul 22 07:32:42 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:42 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F01%20-%20Wei%20LI%2C%20arrangement%20and%20guzheng%20-%20Autumn%20Yearning.dff&metadata=false Jul 22 07:32:42 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff Jul 22 07:32:42 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F02%20-%20Fei%20SONG%2C%20erhu%20-%20Warbling%20On%20A%20Desolate%20Mountain.dff&metadata=false Jul 22 07:32:42 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/02 - Fei SONG, erhu - Warbling On A Desolate Mountain.dff Jul 22 07:32:42 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F03%20-%20Fei%20SONG%2C%20erhu%2C%20impromptu%20accompanied%20by%20Wei%20LI%2C%20guzheng%20-%20Moonlight%20Over%20The%20Spring.dff&metadata=false Jul 22 07:32:42 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/03 - Fei SONG, erhu, impromptu accompanied by Wei LI, guzheng - Moonlight Over The Spring.dff Jul 22 07:32:42 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F04%20-%20Fei%20SONG%2C%20erhu%20-%20The%20Grapes%20Are%20Ripe.dff&metadata=false Jul 22 07:32:42 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/04 - Fei SONG, erhu - The Grapes Are Ripe.dff Jul 22 07:32:42 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F05%20-%20Wei%20LI%2C%20arrangement%20and%20guzheng%20solo%20-%20Variation%20On%20Yang%20Pass.dff&metadata=false Jul 22 07:32:42 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/05 - Wei LI, arrangement and guzheng solo - Variation On Yang Pass.dff Jul 22 07:32:42 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F06%20-%20Fei%20SONG%2C%20erhu%2C%20Wei%20LI%2C%20guzheng%2C%20Lucas%20WONG%2C%20piano%20-%20Flower%20Or%20Not.dff&metadata=false Jul 22 07:32:42 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/06 - Fei SONG, erhu, Wei LI, guzheng, Lucas WONG, piano - Flower Or Not.dff Jul 22 07:32:42 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F07%20-%20Wei%20LI%2C%20guzheng%20-%20Miss%20Qinliang%20Liu.dff&metadata=false Jul 22 07:32:42 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/07 - Wei LI, guzheng - Miss Qinliang Liu.dff Jul 22 07:32:42 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F08%20-%20Ensemble%20-%20Colorful%20Clouds%20Sailing%20Towards%20The%20Moon.dff&metadata=false Jul 22 07:32:42 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/08 - Ensemble - Colorful Clouds Sailing Towards The Moon.dff Jul 22 07:32:42 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F09%20-%20Wei%20LI%2C%20guzheng%20-%20Autumn%20Moon%20Over%20Han%20Palace.dff&metadata=false Jul 22 07:32:42 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/09 - Wei LI, guzheng - Autumn Moon Over Han Palace.dff Jul 22 07:32:42 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F10%20-%20Fei%20SONG%2C%20erhu%20-%20Variation%20On%20River%20Of%20Sorrow.dff&metadata=false Jul 22 07:32:42 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/10 - Fei SONG, erhu - Variation On River Of Sorrow.dff Jul 22 07:32:42 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F11%20-%20Fei%20SONG%2C%20erhu%20-%20Flight%20Of%20The%20Bumblebee.dff&metadata=false Jul 22 07:32:42 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/11 - Fei SONG, erhu - Flight Of The Bumblebee.dff Jul 22 07:32:42 opera volumio[1397]: info: CorePlayQueue::saveQueue Jul 22 07:32:42 opera volumio[1397]: info: CoreCommandRouter::volumioPushQueue Jul 22 07:32:42 opera volumio[1397]: info: CoreStateMachine::updateTrackBlock Jul 22 07:32:42 opera volumio[1397]: info: CorePlayQueue::getTrackBlock Jul 22 07:32:42 opera volumio[1397]: info: CoreCommandRouter::volumioPlay Jul 22 07:32:42 opera volumio[1397]: verbose: UNSET VOLATILE Jul 22 07:32:42 opera volumio[1397]: info: CoreStateMachine::play index 0 Jul 22 07:32:42 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:32:42 opera volumio[1397]: info: CoreStateMachine::stop Jul 22 07:32:42 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:32:42 opera volumio[1397]: verbose: UNSET VOLATILE Jul 22 07:32:42 opera volumio[1397]: info: CoreStateMachine::play index undefined Jul 22 07:32:42 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:32:42 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:42 opera volumio[1397]: info: CoreStateMachine::startPlaybackTimer Jul 22 07:32:42 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:42 opera volumio[1397]: verbose: ControllerMpd::clearAddPlayTracks USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff Jul 22 07:32:42 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand stop Jul 22 07:32:42 opera volumio[1397]: info: sendMpdCommand stop took 4 milliseconds Jul 22 07:32:42 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand clear Jul 22 07:32:42 opera volumio[1397]: info: Jul 22 07:32:42 opera volumio[1397]: ---------------------------- MPD announces system playlist update Jul 22 07:32:42 opera volumio[1397]: info: Ignoring MPD Status Update Jul 22 07:32:42 opera volumio[1397]: info: sendMpdCommand clear took 10 milliseconds Jul 22 07:32:42 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand add "USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff" Jul 22 07:32:42 opera volumio[1397]: error: updateQueue error: null Jul 22 07:32:42 opera volumio[1397]: info: Jul 22 07:32:42 opera volumio[1397]: ---------------------------- MPD announces system playlist update Jul 22 07:32:42 opera volumio[1397]: info: Ignoring MPD Status Update Jul 22 07:32:42 opera volumio[1397]: info: ------------------------------ 8ms Jul 22 07:32:42 opera volumio[1397]: info: sendMpdCommand add "USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff" took 7 milliseconds Jul 22 07:32:42 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand play Jul 22 07:32:42 opera volumio[1397]: info: ------------------------------ 11ms Jul 22 07:32:42 opera volumio[1397]: info: sendMpdCommand play took 9 milliseconds Jul 22 07:32:42 opera volumio[1397]: info: Jul 22 07:32:42 opera volumio[1397]: ---------------------------- MPD announces state update: player Jul 22 07:32:42 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:32:43 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:32:43 opera volumio[1397]: info: Jul 22 07:32:43 opera volumio[1397]: ---------------------------- MPD announces state update: player Jul 22 07:32:43 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:32:43 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:32:43 opera volumio[1397]: info: sendMpdCommand status took 3 milliseconds Jul 22 07:32:43 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:32:43 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 22 07:32:43 opera volumio[1397]: info: sendMpdCommand status took 4 milliseconds Jul 22 07:32:43 opera volumio[1397]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 22 07:32:43 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:32:43 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 22 07:32:43 opera volumio[1397]: verbose: ControllerMpd::parseTrackInfo Jul 22 07:32:43 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:32:43 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:32:43 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:43 opera volumio[1397]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5,"duration":668,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2822 Kbps","isStreaming":false,"title":"01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff","artist":null,"album":null,"uri":"USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff","trackType":"dff"} Jul 22 07:32:43 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:32:43 opera volumio[1397]: info: CoreStateMachine::syncState stateService play Jul 22 07:32:43 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus stop Jul 22 07:32:43 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:43 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:43 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:43 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:43 opera volumio[1397]: info: ------------------------------ 23ms Jul 22 07:32:43 opera volumio[1397]: info: sendMpdCommand playlistinfo took 15 milliseconds Jul 22 07:32:43 opera volumio[1397]: verbose: ControllerMpd::parseTrackInfo Jul 22 07:32:43 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:32:43 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:32:43 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:43 opera volumio[1397]: verbose: STATE SERVICE {"status":"play","position":0,"seek":365,"duration":668,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2822 Kbps","isStreaming":false,"title":"01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff","artist":null,"album":null,"uri":"USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff","trackType":"dff"} Jul 22 07:32:43 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:32:43 opera volumio[1397]: info: CoreStateMachine::syncState stateService play Jul 22 07:32:43 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus play Jul 22 07:32:43 opera volumio[1397]: info: Received an update from plugin. extracting info from payload Jul 22 07:32:43 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:43 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:43 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:43 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:43 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:43 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:43 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:43 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:43 opera volumio[1397]: info: ------------------------------ 42ms Jul 22 07:32:43 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:43 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:43 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:43 opera systemd[1]: Started volumio-remote-updater-push.service. Jul 22 07:32:43 opera systemd[1]: Starting Multi-User System. Jul 22 07:32:43 opera systemd[1]: Reached target Multi-User System. Jul 22 07:32:43 opera systemd[1]: Starting Graphical Interface. Jul 22 07:32:43 opera systemd[1]: Reached target Graphical Interface. Jul 22 07:32:43 opera systemd[1]: Starting Update UTMP about System Runlevel Changes... Jul 22 07:32:43 opera volumio[1397]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 07:32:43 opera systemd[1]: Started Update UTMP about System Runlevel Changes. Jul 22 07:32:43 opera systemd[1]: Startup finished in 14.514s (kernel) + 2min 5.126s (userspace) = 2min 19.641s. Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::ClearQueue Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::stop Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:32:56 opera volumio[1397]: verbose: UNSET VOLATILE Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::stPlaybackTimer Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::updateTrackBlock Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::getTrackBlock Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::serviceStop Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::serviceStop Jul 22 07:32:56 opera volumio[1397]: info: ControllerMpd::stop Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand stop Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::clearPlayQueue Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::saveQueue Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::volumioPushQueue Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::addQueueItems Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::addQueueItems Jul 22 07:32:56 opera volumio[1397]: info: Adding Item to queue: music-library/USB/DSD...600/1..DSD/Autumn Yearning Jul 22 07:32:56 opera volumio[1397]: info: Exploding uri music-library/USB/DSD...600/1..DSD/Autumn Yearning in service mpd Jul 22 07:32:56 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:56 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:56 opera volumio[1397]: info: sendMpdCommand stop took 78 milliseconds Jul 22 07:32:56 opera volumio[1397]: info: Jul 22 07:32:56 opera volumio[1397]: ---------------------------- MPD announces state update: player Jul 22 07:32:56 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F01%20-%20Wei%20LI%2C%20arrangement%20and%20guzheng%20-%20Autumn%20Yearning.dff&metadata=false Jul 22 07:32:56 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff Jul 22 07:32:56 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F02%20-%20Fei%20SONG%2C%20erhu%20-%20Warbling%20On%20A%20Desolate%20Mountain.dff&metadata=false Jul 22 07:32:56 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/02 - Fei SONG, erhu - Warbling On A Desolate Mountain.dff Jul 22 07:32:56 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F03%20-%20Fei%20SONG%2C%20erhu%2C%20impromptu%20accompanied%20by%20Wei%20LI%2C%20guzheng%20-%20Moonlight%20Over%20The%20Spring.dff&metadata=false Jul 22 07:32:56 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/03 - Fei SONG, erhu, impromptu accompanied by Wei LI, guzheng - Moonlight Over The Spring.dff Jul 22 07:32:56 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F04%20-%20Fei%20SONG%2C%20erhu%20-%20The%20Grapes%20Are%20Ripe.dff&metadata=false Jul 22 07:32:56 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/04 - Fei SONG, erhu - The Grapes Are Ripe.dff Jul 22 07:32:56 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F05%20-%20Wei%20LI%2C%20arrangement%20and%20guzheng%20solo%20-%20Variation%20On%20Yang%20Pass.dff&metadata=false Jul 22 07:32:56 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/05 - Wei LI, arrangement and guzheng solo - Variation On Yang Pass.dff Jul 22 07:32:56 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F06%20-%20Fei%20SONG%2C%20erhu%2C%20Wei%20LI%2C%20guzheng%2C%20Lucas%20WONG%2C%20piano%20-%20Flower%20Or%20Not.dff&metadata=false Jul 22 07:32:56 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/06 - Fei SONG, erhu, Wei LI, guzheng, Lucas WONG, piano - Flower Or Not.dff Jul 22 07:32:56 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F07%20-%20Wei%20LI%2C%20guzheng%20-%20Miss%20Qinliang%20Liu.dff&metadata=false Jul 22 07:32:56 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/07 - Wei LI, guzheng - Miss Qinliang Liu.dff Jul 22 07:32:56 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F08%20-%20Ensemble%20-%20Colorful%20Clouds%20Sailing%20Towards%20The%20Moon.dff&metadata=false Jul 22 07:32:56 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/08 - Ensemble - Colorful Clouds Sailing Towards The Moon.dff Jul 22 07:32:56 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F09%20-%20Wei%20LI%2C%20guzheng%20-%20Autumn%20Moon%20Over%20Han%20Palace.dff&metadata=false Jul 22 07:32:56 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/09 - Wei LI, guzheng - Autumn Moon Over Han Palace.dff Jul 22 07:32:56 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F10%20-%20Fei%20SONG%2C%20erhu%20-%20Variation%20On%20River%20Of%20Sorrow.dff&metadata=false Jul 22 07:32:56 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/10 - Fei SONG, erhu - Variation On River Of Sorrow.dff Jul 22 07:32:56 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FAutumn%20Yearning%2F11%20-%20Fei%20SONG%2C%20erhu%20-%20Flight%20Of%20The%20Bumblebee.dff&metadata=false Jul 22 07:32:56 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Autumn Yearning/11 - Fei SONG, erhu - Flight Of The Bumblebee.dff Jul 22 07:32:56 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::saveQueue Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::volumioPushQueue Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::updateTrackBlock Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::getTrackBlock Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::volumioPlay Jul 22 07:32:56 opera volumio[1397]: verbose: UNSET VOLATILE Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::play index 0 Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::stop Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:32:56 opera volumio[1397]: verbose: UNSET VOLATILE Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::play index undefined Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::startPlaybackTimer Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::clearAddPlayTracks USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand stop Jul 22 07:32:56 opera volumio[1397]: info: sendMpdCommand status took 10 milliseconds Jul 22 07:32:56 opera volumio[1397]: info: sendMpdCommand stop took 2 milliseconds Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand clear Jul 22 07:32:56 opera volumio[1397]: info: Jul 22 07:32:56 opera volumio[1397]: ---------------------------- MPD announces system playlist update Jul 22 07:32:56 opera volumio[1397]: info: Ignoring MPD Status Update Jul 22 07:32:56 opera volumio[1397]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 22 07:32:56 opera volumio[1397]: info: sendMpdCommand clear took 2 milliseconds Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::parseTrackInfo Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand add "USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff" Jul 22 07:32:56 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:56 opera volumio[1397]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff","artist":null,"album":null,"uri":"USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff","trackType":"dff"} Jul 22 07:32:56 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::syncState stateService stop Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus stop Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:56 opera volumio[1397]: info: No code Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:56 opera volumio[1397]: info: ------------------------------ 28ms Jul 22 07:32:56 opera volumio[1397]: error: updateQueue error: null Jul 22 07:32:56 opera volumio[1397]: info: Jul 22 07:32:56 opera volumio[1397]: ---------------------------- MPD announces system playlist update Jul 22 07:32:56 opera volumio[1397]: info: Ignoring MPD Status Update Jul 22 07:32:56 opera volumio[1397]: info: ------------------------------ 18ms Jul 22 07:32:56 opera volumio[1397]: info: sendMpdCommand add "USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff" took 17 milliseconds Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand play Jul 22 07:32:56 opera volumio[1397]: info: ------------------------------ 6ms Jul 22 07:32:56 opera volumio[1397]: info: sendMpdCommand play took 4 milliseconds Jul 22 07:32:56 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:56 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:56 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:32:56 opera volumio[1397]: info: Jul 22 07:32:56 opera volumio[1397]: ---------------------------- MPD announces state update: player Jul 22 07:32:56 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:32:56 opera volumio[1397]: info: sendMpdCommand status took 1 milliseconds Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 22 07:32:56 opera volumio[1397]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 22 07:32:56 opera volumio[1397]: verbose: ControllerMpd::parseTrackInfo Jul 22 07:32:56 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:56 opera volumio[1397]: verbose: STATE SERVICE {"status":"play","position":0,"seek":365,"duration":668,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2822 Kbps","isStreaming":false,"title":"01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff","artist":null,"album":null,"uri":"USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff","trackType":"dff"} Jul 22 07:32:56 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::syncState stateService play Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus stop Jul 22 07:32:56 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:32:56 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:32:56 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:32:56 opera volumio[1397]: info: ------------------------------ 11ms Jul 22 07:32:56 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::ClearQueue Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::stop Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:33:10 opera volumio[1397]: verbose: UNSET VOLATILE Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::stPlaybackTimer Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::updateTrackBlock Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrackBlock Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::serviceStop Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::serviceStop Jul 22 07:33:10 opera volumio[1397]: info: ControllerMpd::stop Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand stop Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::clearPlayQueue Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::saveQueue Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::volumioPushQueue Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::addQueueItems Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::addQueueItems Jul 22 07:33:10 opera volumio[1397]: info: Adding Item to queue: music-library/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1 Jul 22 07:33:10 opera volumio[1397]: info: Exploding uri music-library/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1 in service mpd Jul 22 07:33:10 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:10 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:10 opera volumio[1397]: info: Jul 22 07:33:10 opera volumio[1397]: ---------------------------- MPD announces state update: player Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F01%20-%20Julia%20Fischer%20-%20Sonata%20No.1%20in%20G%20minor%2C%20BWV%201001%20-%20Adagio.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F02%20-%20Julia%20Fischer%20-%20Sonata%20No.1%20in%20G%20minor%2C%20BWV%201001%20-%20Fuga%20(Allegro).dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/02 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Fuga (Allegro).dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F03%20-%20Julia%20Fischer%20-%20Sonata%20No.1%20in%20G%20minor%2C%20BWV%201001%20-%20Siciliana.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/03 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Siciliana.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F04%20-%20Julia%20Fischer%20-%20Sonata%20No.1%20in%20G%20minor%2C%20BWV%201001%20-%20Presto.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/04 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Presto.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F05%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Allemanda.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/05 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Allemanda.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F06%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Double.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/06 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Double.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F07%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Corrente.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/07 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Corrente.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F08%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Double%20(Presto).dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/08 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Double (Presto).dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F09%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Sarabande.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/09 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Sarabande.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F10%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Double.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/10 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Double.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F11%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Tempo%20di%20Borea.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/11 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Tempo di Borea.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F12%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Double.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/12 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Double.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F13%20-%20Julia%20Fischer%20-%20Sonata%20No.2%20in%20A%20minor%2C%20BWV%201003%20-%20Grave.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/13 - Julia Fischer - Sonata No.2 in A minor, BWV 1003 - Grave.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F14%20-%20Julia%20Fischer%20-%20Sonata%20No.2%20in%20A%20minor%2C%20BWV%201003%20-%20Fuga.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/14 - Julia Fischer - Sonata No.2 in A minor, BWV 1003 - Fuga.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F15%20-%20Julia%20Fischer%20-%20Sonata%20No.2%20in%20A%20minor%2C%20BWV%201003%20-%20Andante.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/15 - Julia Fischer - Sonata No.2 in A minor, BWV 1003 - Andante.dff Jul 22 07:33:10 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F16%20-%20Julia%20Fischer%20-%20Sonata%20No.2%20in%20A%20minor%2C%20BWV%201003%20-%20Allegro.dff&metadata=false Jul 22 07:33:10 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/16 - Julia Fischer - Sonata No.2 in A minor, BWV 1003 - Allegro.dff Jul 22 07:33:10 opera volumio[1397]: info: sendMpdCommand stop took 37 milliseconds Jul 22 07:33:10 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::saveQueue Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::volumioPushQueue Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::updateTrackBlock Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrackBlock Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::volumioPlay Jul 22 07:33:10 opera volumio[1397]: verbose: UNSET VOLATILE Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::play index 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::stop Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:33:10 opera volumio[1397]: verbose: UNSET VOLATILE Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::play index undefined Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::startPlaybackTimer Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::clearAddPlayTracks USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand stop Jul 22 07:33:10 opera volumio[1397]: info: sendMpdCommand status took 12 milliseconds Jul 22 07:33:10 opera volumio[1397]: info: sendMpdCommand stop took 4 milliseconds Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand clear Jul 22 07:33:10 opera volumio[1397]: info: Jul 22 07:33:10 opera volumio[1397]: ---------------------------- MPD announces system playlist update Jul 22 07:33:10 opera volumio[1397]: info: Ignoring MPD Status Update Jul 22 07:33:10 opera volumio[1397]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 22 07:33:10 opera volumio[1397]: info: sendMpdCommand clear took 4 milliseconds Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::parseTrackInfo Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand add "USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff" Jul 22 07:33:10 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff","artist":null,"album":null,"uri":"USB/DSD...600/1..DSD/Autumn Yearning/01 - Wei LI, arrangement and guzheng - Autumn Yearning.dff","trackType":"dff"} Jul 22 07:33:10 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::syncState stateService stop Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus stop Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:10 opera volumio[1397]: info: No code Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:10 opera volumio[1397]: info: ------------------------------ 44ms Jul 22 07:33:10 opera volumio[1397]: error: updateQueue error: null Jul 22 07:33:10 opera volumio[1397]: info: Jul 22 07:33:10 opera volumio[1397]: ---------------------------- MPD announces system playlist update Jul 22 07:33:10 opera volumio[1397]: info: Ignoring MPD Status Update Jul 22 07:33:10 opera volumio[1397]: info: ------------------------------ 22ms Jul 22 07:33:10 opera volumio[1397]: info: sendMpdCommand add "USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff" took 21 milliseconds Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand play Jul 22 07:33:10 opera volumio[1397]: info: ------------------------------ 6ms Jul 22 07:33:10 opera volumio[1397]: info: sendMpdCommand play took 6 milliseconds Jul 22 07:33:10 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:10 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:10 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:10 opera volumio[1397]: info: Jul 22 07:33:10 opera volumio[1397]: ---------------------------- MPD announces state update: player Jul 22 07:33:10 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:33:10 opera volumio[1397]: info: Jul 22 07:33:10 opera volumio[1397]: ---------------------------- MPD announces state update: player Jul 22 07:33:10 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:33:10 opera volumio[1397]: info: sendMpdCommand status took 2 milliseconds Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 22 07:33:10 opera volumio[1397]: info: sendMpdCommand status took 2 milliseconds Jul 22 07:33:10 opera volumio[1397]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::parseTrackInfo Jul 22 07:33:10 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23,"duration":281,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2822 Kbps","isStreaming":false,"title":"01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff","artist":null,"album":null,"uri":"USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff","trackType":"dff"} Jul 22 07:33:10 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::syncState stateService play Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus stop Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:10 opera volumio[1397]: info: ------------------------------ 18ms Jul 22 07:33:10 opera volumio[1397]: info: sendMpdCommand playlistinfo took 12 milliseconds Jul 22 07:33:10 opera volumio[1397]: verbose: ControllerMpd::parseTrackInfo Jul 22 07:33:10 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: verbose: STATE SERVICE {"status":"play","position":0,"seek":243,"duration":281,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2822 Kbps","isStreaming":false,"title":"01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff","artist":null,"album":null,"uri":"USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff","trackType":"dff"} Jul 22 07:33:10 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::syncState stateService play Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus play Jul 22 07:33:10 opera volumio[1397]: info: Received an update from plugin. extracting info from payload Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:10 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:10 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:10 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:10 opera volumio[1397]: info: ------------------------------ 35ms Jul 22 07:33:10 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:10 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:10 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::ClearQueue Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::stop Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:33:30 opera volumio[1397]: verbose: UNSET VOLATILE Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::stPlaybackTimer Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::updateTrackBlock Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrackBlock Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::serviceStop Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::serviceStop Jul 22 07:33:30 opera volumio[1397]: info: ControllerMpd::stop Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand stop Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::clearPlayQueue Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::saveQueue Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::volumioPushQueue Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::addQueueItems Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::addQueueItems Jul 22 07:33:30 opera volumio[1397]: info: Adding Item to queue: music-library/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1 Jul 22 07:33:30 opera volumio[1397]: info: Exploding uri music-library/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1 in service mpd Jul 22 07:33:30 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:30 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:30 opera volumio[1397]: info: sendMpdCommand stop took 61 milliseconds Jul 22 07:33:30 opera volumio[1397]: info: Jul 22 07:33:30 opera volumio[1397]: ---------------------------- MPD announces state update: player Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F01%20-%20Julia%20Fischer%20-%20Sonata%20No.1%20in%20G%20minor%2C%20BWV%201001%20-%20Adagio.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F02%20-%20Julia%20Fischer%20-%20Sonata%20No.1%20in%20G%20minor%2C%20BWV%201001%20-%20Fuga%20(Allegro).dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/02 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Fuga (Allegro).dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F03%20-%20Julia%20Fischer%20-%20Sonata%20No.1%20in%20G%20minor%2C%20BWV%201001%20-%20Siciliana.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/03 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Siciliana.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F04%20-%20Julia%20Fischer%20-%20Sonata%20No.1%20in%20G%20minor%2C%20BWV%201001%20-%20Presto.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/04 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Presto.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F05%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Allemanda.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/05 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Allemanda.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F06%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Double.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/06 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Double.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F07%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Corrente.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/07 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Corrente.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F08%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Double%20(Presto).dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/08 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Double (Presto).dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F09%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Sarabande.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/09 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Sarabande.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F10%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Double.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/10 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Double.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F11%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Tempo%20di%20Borea.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/11 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Tempo di Borea.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F12%20-%20Julia%20Fischer%20-%20Partita%20No.1%20in%20B%20minor%2C%20BWV%201002%20-%20Double.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/12 - Julia Fischer - Partita No.1 in B minor, BWV 1002 - Double.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F13%20-%20Julia%20Fischer%20-%20Sonata%20No.2%20in%20A%20minor%2C%20BWV%201003%20-%20Grave.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/13 - Julia Fischer - Sonata No.2 in A minor, BWV 1003 - Grave.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F14%20-%20Julia%20Fischer%20-%20Sonata%20No.2%20in%20A%20minor%2C%20BWV%201003%20-%20Fuga.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/14 - Julia Fischer - Sonata No.2 in A minor, BWV 1003 - Fuga.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F15%20-%20Julia%20Fischer%20-%20Sonata%20No.2%20in%20A%20minor%2C%20BWV%201003%20-%20Andante.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/15 - Julia Fischer - Sonata No.2 in A minor, BWV 1003 - Andante.dff Jul 22 07:33:30 opera volumio[1397]: info: ALBUMART /albumart?cacheid=390&web=//extralarge&path=%2Fmnt%2FUSB%2FDSD...600%2F1..DSD%2FBach%20(1685-1750)%20-%20Sonatas%20and%20Partitas%20-1%2F16%20-%20Julia%20Fischer%20-%20Sonata%20No.2%20in%20A%20minor%2C%20BWV%201003%20-%20Allegro.dff&metadata=false Jul 22 07:33:30 opera volumio[1397]: info: URI /mnt/USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/16 - Julia Fischer - Sonata No.2 in A minor, BWV 1003 - Allegro.dff Jul 22 07:33:30 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::saveQueue Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::volumioPushQueue Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::updateTrackBlock Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrackBlock Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::volumioPlay Jul 22 07:33:30 opera volumio[1397]: verbose: UNSET VOLATILE Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::play index 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::stop Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:33:30 opera volumio[1397]: verbose: UNSET VOLATILE Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::play index undefined Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::startPlaybackTimer Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::clearAddPlayTracks USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand stop Jul 22 07:33:30 opera volumio[1397]: info: sendMpdCommand status took 15 milliseconds Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 22 07:33:30 opera volumio[1397]: info: sendMpdCommand stop took 10 milliseconds Jul 22 07:33:30 opera volumio[1397]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand clear Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::parseTrackInfo Jul 22 07:33:30 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff","artist":null,"album":null,"uri":"USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff","trackType":"dff"} Jul 22 07:33:30 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::syncState stateService stop Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus stop Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:30 opera volumio[1397]: info: No code Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:30 opera volumio[1397]: info: ------------------------------ 49ms Jul 22 07:33:30 opera volumio[1397]: info: Jul 22 07:33:30 opera volumio[1397]: ---------------------------- MPD announces system playlist update Jul 22 07:33:30 opera volumio[1397]: info: Ignoring MPD Status Update Jul 22 07:33:30 opera volumio[1397]: info: sendMpdCommand clear took 17 milliseconds Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand add "USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff" Jul 22 07:33:30 opera volumio[1397]: error: updateQueue error: null Jul 22 07:33:30 opera volumio[1397]: info: ------------------------------ 8ms Jul 22 07:33:30 opera volumio[1397]: info: Jul 22 07:33:30 opera volumio[1397]: ---------------------------- MPD announces system playlist update Jul 22 07:33:30 opera volumio[1397]: info: Ignoring MPD Status Update Jul 22 07:33:30 opera volumio[1397]: info: sendMpdCommand add "USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff" took 7 milliseconds Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand play Jul 22 07:33:30 opera volumio[1397]: info: Jul 22 07:33:30 opera volumio[1397]: ---------------------------- MPD announces state update: player Jul 22 07:33:30 opera volumio[1397]: info: ------------------------------ 14ms Jul 22 07:33:30 opera volumio[1397]: info: sendMpdCommand play took 13 milliseconds Jul 22 07:33:30 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:33:30 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:30 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:30 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:30 opera volumio[1397]: info: Jul 22 07:33:30 opera volumio[1397]: ---------------------------- MPD announces state update: player Jul 22 07:33:30 opera volumio[1397]: info: ControllerMpd::getState Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand status Jul 22 07:33:30 opera volumio[1397]: info: sendMpdCommand status took 7 milliseconds Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 22 07:33:30 opera volumio[1397]: info: sendMpdCommand status took 4 milliseconds Jul 22 07:33:30 opera volumio[1397]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::parseState Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::parseTrackInfo Jul 22 07:33:30 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: verbose: STATE SERVICE {"status":"play","position":0,"seek":365,"duration":281,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2822 Kbps","isStreaming":false,"title":"01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff","artist":null,"album":null,"uri":"USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff","trackType":"dff"} Jul 22 07:33:30 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::syncState stateService play Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus stop Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:30 opera volumio[1397]: info: ------------------------------ 20ms Jul 22 07:33:30 opera volumio[1397]: info: sendMpdCommand playlistinfo took 8 milliseconds Jul 22 07:33:30 opera volumio[1397]: verbose: ControllerMpd::parseTrackInfo Jul 22 07:33:30 opera volumio[1397]: info: ControllerMpd::pushState Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::servicePushState Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: verbose: STATE SERVICE {"status":"play","position":0,"seek":365,"duration":281,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2822 Kbps","isStreaming":false,"title":"01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff","artist":null,"album":null,"uri":"USB/DSD...600/1..DSD/Bach (1685-1750) - Sonatas and Partitas -1/01 - Julia Fischer - Sonata No.1 in G minor, BWV 1001 - Adagio.dff","trackType":"dff"} Jul 22 07:33:30 opera volumio[1397]: verbose: CURRENT POSITION 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::syncState stateService play Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::syncState currentStatus play Jul 22 07:33:30 opera volumio[1397]: info: Received an update from plugin. extracting info from payload Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:30 opera volumio[1397]: info: CoreStateMachine::pushState Jul 22 07:33:30 opera volumio[1397]: info: CorePlayQueue::getTrack 0 Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::volumioPushState Jul 22 07:33:30 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 07:33:30 opera volumio[1397]: info: ------------------------------ 30ms Jul 22 07:33:30 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:30 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:30 opera volumio[1397]: info: Updating RAAT Signal Path Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 22 07:33:41 opera volumio[1397]: No protocol specified Jul 22 07:33:41 opera volumio[1397]: xcb_connection_has_error() returned true Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 22 07:33:41 opera volumio[1397]: No protocol specified Jul 22 07:33:41 opera volumio[1397]: xcb_connection_has_error() returned true Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 07:33:41 opera volumio[1397]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 07:33:44 opera volumio[1397]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 07:33:44 opera volumio[1397]: { Error: connect ETIMEDOUT 103.252.115.153:80 Jul 22 07:33:44 opera volumio[1397]: at Object._errnoException (util.js:1022:11) Jul 22 07:33:44 opera volumio[1397]: at _exceptionWithHostPort (util.js:1044:20) Jul 22 07:33:44 opera volumio[1397]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jul 22 07:33:44 opera volumio[1397]: code: 'ETIMEDOUT', Jul 22 07:33:44 opera volumio[1397]: errno: 'ETIMEDOUT', Jul 22 07:33:44 opera volumio[1397]: syscall: 'connect', Jul 22 07:33:44 opera volumio[1397]: address: '103.252.115.153', Jul 22 07:33:44 opera volumio[1397]: port: 80 } Jul 22 07:33:44 opera volumio[1397]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 07:33:44 opera sudo[2340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 07:32 Jul 22 07:33:44 opera sudo[2340]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"