Jun 08 01:45:41 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioGetState Jun 08 01:45:41 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:45:56 volumiopi5 systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 08 01:45:56 volumiopi5 dbus-daemon[946]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.150' (uid=0 pid=18198 comm="timedatectl show --property=NTPSynchronized --valu") Jun 08 01:45:56 volumiopi5 systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 08 01:45:56 volumiopi5 dbus-daemon[946]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 08 01:45:56 volumiopi5 systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 08 01:45:56 volumiopi5 setdatetime-helper.sh[18197]: Time is already synchronized. Jun 08 01:45:56 volumiopi5 systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 08 01:45:56 volumiopi5 systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Preload queue cleared Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::ClearQueue Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::stop Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::stPlaybackTimer Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::updateTrackBlock Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrackBlock Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::serviceStop Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::serviceStop Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::stop Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand stop Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::clearPlayQueue Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::saveQueue Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushQueue Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::addQueueItems Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::addQueueItems Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Preload queue cleared Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Adding Item to queue: music-library/USB/Music/0 SACD/陳潔麗 - 好久不見 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Exploding uri music-library/USB/Music/0 SACD/陳潔麗 - 好久不見 in service mpd Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is not playing Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Clipped samples monitor stopped Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Jun 08 01:46:10 volumiopi5 volumio[1253]: ---------------------------- MPD announces state update: player Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=%E9%99%B3%E6%BD%94%E9%BA%97/%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B/extralarge&path=%2Fmnt%2FUSB%2FMusic%2F0%20%20SACD%2F%E9%99%B3%E6%BD%94%E9%BA%97%20-%20%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B%2F01%20-%20%E8%BF%B7%E4%BA%82(%E5%9C%8B%E8%AA%9E).dsf&metadata=false Jun 08 01:46:10 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/0 SACD/陳潔麗 - 好久不見/01 - 迷亂(國語).dsf Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=%E9%99%B3%E6%BD%94%E9%BA%97/%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B/extralarge&path=%2Fmnt%2FUSB%2FMusic%2F0%20%20SACD%2F%E9%99%B3%E6%BD%94%E9%BA%97%20-%20%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B%2F02%20-%20%E6%88%91%E7%AD%89%E5%88%B0%E8%8A%B1%E5%85%92%E4%B9%9F%E8%AC%9D%E4%BA%86(%E5%9C%8B%E8%AA%9E).dsf&metadata=false Jun 08 01:46:10 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/0 SACD/陳潔麗 - 好久不見/02 - 我等到花兒也謝了(國語).dsf Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=%E9%99%B3%E6%BD%94%E9%BA%97/%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B/extralarge&path=%2Fmnt%2FUSB%2FMusic%2F0%20%20SACD%2F%E9%99%B3%E6%BD%94%E9%BA%97%20-%20%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B%2F03%20-%E7%AA%81%E7%84%B6%E6%83%B3%E6%84%9B%E4%BD%A0(%E5%9C%8B%E8%AA%9E).dsf&metadata=false Jun 08 01:46:10 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/0 SACD/陳潔麗 - 好久不見/03 -突然想愛你(國語).dsf Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=%E9%99%B3%E6%BD%94%E9%BA%97/%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B/extralarge&path=%2Fmnt%2FUSB%2FMusic%2F0%20%20SACD%2F%E9%99%B3%E6%BD%94%E9%BA%97%20-%20%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B%2F04%20-DEAR%20FRIEND%20(%E5%9C%8B%E8%AA%9E).dsf&metadata=false Jun 08 01:46:10 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/0 SACD/陳潔麗 - 好久不見/04 -DEAR FRIEND (國語).dsf Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=%E9%99%B3%E6%BD%94%E9%BA%97/%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B/extralarge&path=%2Fmnt%2FUSB%2FMusic%2F0%20%20SACD%2F%E9%99%B3%E6%BD%94%E9%BA%97%20-%20%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B%2F05%20-%20%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B(%E5%9C%8B%E8%AA%9E).dsf&metadata=false Jun 08 01:46:10 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/0 SACD/陳潔麗 - 好久不見/05 - 好久不見(國語).dsf Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=%E9%99%B3%E6%BD%94%E9%BA%97/%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B/extralarge&path=%2Fmnt%2FUSB%2FMusic%2F0%20%20SACD%2F%E9%99%B3%E6%BD%94%E9%BA%97%20-%20%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B%2F06%20-%20%E7%A7%8B%E6%84%8F%E6%BF%83(%E5%9C%8B%E8%AA%9E).dsf&metadata=false Jun 08 01:46:10 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/0 SACD/陳潔麗 - 好久不見/06 - 秋意濃(國語).dsf Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=%E9%99%B3%E6%BD%94%E9%BA%97/%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B/extralarge&path=%2Fmnt%2FUSB%2FMusic%2F0%20%20SACD%2F%E9%99%B3%E6%BD%94%E9%BA%97%20-%20%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B%2F07%20-%20%E5%AE%88%E6%99%82(%E7%B2%B5%E8%AA%9E).dsf&metadata=false Jun 08 01:46:10 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/0 SACD/陳潔麗 - 好久不見/07 - 守時(粵語).dsf Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=%E9%99%B3%E6%BD%94%E9%BA%97/%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B/extralarge&path=%2Fmnt%2FUSB%2FMusic%2F0%20%20SACD%2F%E9%99%B3%E6%BD%94%E9%BA%97%20-%20%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B%2F08%20-%20%E7%A5%9D%E5%90%9B%E5%A5%BD(%E5%9C%8B%E8%AA%9E).dsf&metadata=false Jun 08 01:46:10 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/0 SACD/陳潔麗 - 好久不見/08 - 祝君好(國語).dsf Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=%E9%99%B3%E6%BD%94%E9%BA%97/%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B/extralarge&path=%2Fmnt%2FUSB%2FMusic%2F0%20%20SACD%2F%E9%99%B3%E6%BD%94%E9%BA%97%20-%20%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B%2F09%20-%20%E6%9C%88%E5%8D%8A%E5%BD%8E(%E5%9C%8B%E8%AA%9E).dsf&metadata=false Jun 08 01:46:10 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/0 SACD/陳潔麗 - 好久不見/09 - 月半彎(國語).dsf Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=%E9%99%B3%E6%BD%94%E9%BA%97/%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B/extralarge&path=%2Fmnt%2FUSB%2FMusic%2F0%20%20SACD%2F%E9%99%B3%E6%BD%94%E9%BA%97%20-%20%E5%A5%BD%E4%B9%85%E4%B8%8D%E8%A6%8B%2F10%20-%20%E8%97%8D%E6%9C%88%E4%BA%AE%20(%E7%B2%B5%E8%AA%9E).dsf&metadata=false Jun 08 01:46:10 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/0 SACD/陳潔麗 - 好久不見/10 - 藍月亮 (粵語).dsf Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand stop took 11 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::getState Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand status Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushQueue Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::saveQueue Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::updateTrackBlock Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrackBlock Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPlay Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::play index 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::stop Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::play index undefined Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::startPlaybackTimer Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::clearAddPlayTracks USB/Music/0 SACD/陳潔麗 - 好久不見/01 - 迷亂(國語).dsf Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand stop Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand status took 8 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand stop took 1 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::parseState Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand clear Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Jun 08 01:46:10 volumiopi5 volumio[1253]: ---------------------------- MPD announces state update: player Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::getState Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand status Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Jun 08 01:46:10 volumiopi5 volumio[1253]: ---------------------------- MPD announces system playlist update Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Ignoring MPD Status Update Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand clear took 1 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand status took 1 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::parseTrackInfo Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand add "USB/Music/0 SACD/陳潔麗 - 好久不見/01 - 迷亂(國語).dsf" Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::parseState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::servicePushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: 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 - Jheena Lodwick - A Groovy Kind of Love.dff","artist":null,"album":null,"uri":"USB/Music/0 SACD/AV Show 2004/01 - Jheena Lodwick - A Groovy Kind of Love.dff","trackType":"dff"} Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: CURRENT POSITION 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::syncState stateService stop Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::syncState currentStatus stop Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: No code Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::servicePushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: 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} Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: CURRENT POSITION 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::syncState stateService stop Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::syncState currentStatus stop Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: No code Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ------------------------------ 35ms Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ------------------------------ 26ms Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Jun 08 01:46:10 volumiopi5 volumio[1253]: ---------------------------- MPD announces system playlist update Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Ignoring MPD Status Update Jun 08 01:46:10 volumiopi5 volumio[1253]: error: updateQueue error: null Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Jun 08 01:46:10 volumiopi5 volumio[1253]: ---------------------------- MPD announces system playlist update Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Ignoring MPD Status Update Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ------------------------------ 28ms Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand add "USB/Music/0 SACD/陳潔麗 - 好久不見/01 - 迷亂(國語).dsf" took 29 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ------------------------------ 4ms Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand play Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Jun 08 01:46:10 volumiopi5 volumio[1253]: ---------------------------- MPD announces system playlist update Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Ignoring MPD Status Update Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is not playing Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Clipped samples monitor stopped Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is not playing Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Clipped samples monitor stopped Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is not playing Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Clipped samples monitor stopped Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is not playing Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Clipped samples monitor stopped Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is not playing Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Clipped samples monitor stopped Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is not playing Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Clipped samples monitor stopped Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Jun 08 01:46:10 volumiopi5 volumio[1253]: ---------------------------- MPD announces state update: player Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ------------------------------ 36ms Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand play took 35 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ------------------------------ 35ms Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::getState Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand status Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Jun 08 01:46:10 volumiopi5 volumio[1253]: ---------------------------- MPD announces state update: player Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::getState Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand status Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - ---- read samplerate, raw: 352800,S32_LE,2,32 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - ---- read samplerate from file: 352800 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Jun 08 01:46:10 volumiopi5 volumio[1253]: ---------------------------- MPD announces state update: player Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::getState Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand status Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand status took 19 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand status took 19 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::parseState Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::parseState Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Jun 08 01:46:10 volumiopi5 volumio[1253]: ---------------------------- MPD announces state update: player Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::getState Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand status Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand status took 5 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand status took 3 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::parseState Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::parseTrackInfo Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::parseTrackInfo Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::parseState Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::servicePushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: STATE SERVICE {"status":"play","position":0,"seek":361,"duration":288,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"MI LUAN","artist":"陳潔麗","album":"好久不見","uri":"USB/Music/0 SACD/陳潔麗 - 好久不見/01 - 迷亂(國語).dsf","trackType":"dsf"} Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: CURRENT POSITION 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::syncState stateService play Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::syncState currentStatus stop Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::servicePushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: STATE SERVICE {"status":"play","position":0,"seek":361,"duration":288,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"MI LUAN","artist":"陳潔麗","album":"好久不見","uri":"USB/Music/0 SACD/陳潔麗 - 好久不見/01 - 迷亂(國語).dsf","trackType":"dsf"} Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: CURRENT POSITION 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::syncState stateService play Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::syncState currentStatus play Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Received an update from plugin. extracting info from payload Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ------------------------------ 38ms Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ------------------------------ 39ms Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::parseTrackInfo Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: ControllerMpd::parseTrackInfo Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::servicePushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: STATE SERVICE {"status":"play","position":0,"seek":361,"duration":288,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"MI LUAN","artist":"陳潔麗","album":"好久不見","uri":"USB/Music/0 SACD/陳潔麗 - 好久不見/01 - 迷亂(國語).dsf","trackType":"dsf"} Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: CURRENT POSITION 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::syncState stateService play Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::syncState currentStatus play Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Received an update from plugin. extracting info from payload Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ControllerMpd::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::servicePushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: STATE SERVICE {"status":"play","position":0,"seek":361,"duration":288,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"MI LUAN","artist":"陳潔麗","album":"好久不見","uri":"USB/Music/0 SACD/陳潔麗 - 好久不見/01 - 迷亂(國語).dsf","trackType":"dsf"} Jun 08 01:46:10 volumiopi5 volumio[1253]: verbose: CURRENT POSITION 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::syncState stateService play Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::syncState currentStatus play Jun 08 01:46:10 volumiopi5 volumio[1253]: info: Received an update from plugin. extracting info from payload Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:10 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:10 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ------------------------------ 49ms Jun 08 01:46:10 volumiopi5 volumio[1253]: info: ------------------------------ 42ms Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is playing Jun 08 01:46:10 volumiopi5 volumio[1253]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is playing Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is playing Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is playing Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is playing Jun 08 01:46:10 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is playing Jun 08 01:46:10 volumiopi5 volumio[1253]: error: FusionDsp - Reload WebSocket error: [object Object] Jun 08 01:46:10 volumiopi5 volumio[1253]: error: FusionDsp - Monitor WebSocket error: [object Object] Jun 08 01:46:10 volumiopi5 volumio[1253]: error: FusionDsp - Monitor WebSocket error: [object Object] Jun 08 01:46:10 volumiopi5 volumio[1253]: error: FusionDsp - Monitor WebSocket error: [object Object] Jun 08 01:46:10 volumiopi5 volumio[1253]: error: FusionDsp - Monitor WebSocket error: [object Object] Jun 08 01:46:10 volumiopi5 volumio[1253]: error: FusionDsp - Monitor WebSocket error: [object Object] Jun 08 01:46:10 volumiopi5 volumio[1253]: error: FusionDsp - Monitor WebSocket error: [object Object] Jun 08 01:46:12 volumiopi5 volumio[1253]: info: FusionDsp - Clipping Monitor started Jun 08 01:46:12 volumiopi5 volumio[1253]: info: FusionDsp - Clipping Monitor started Jun 08 01:46:12 volumiopi5 volumio[1253]: info: FusionDsp - Clipping Monitor started Jun 08 01:46:12 volumiopi5 volumio[1253]: info: FusionDsp - Clipping Monitor started Jun 08 01:46:12 volumiopi5 volumio[1253]: info: FusionDsp - Clipping Monitor started Jun 08 01:46:12 volumiopi5 volumio[1253]: info: FusionDsp - Clipping Monitor started Jun 08 01:46:12 volumiopi5 volumio[1253]: info: FusionDsp - Clipping Monitor started Jun 08 01:46:12 volumiopi5 volumio[1253]: info: FusionDsp - Clipping Monitor started Jun 08 01:46:12 volumiopi5 volumio[1253]: info: FusionDsp - Clipping Monitor started Jun 08 01:46:12 volumiopi5 volumio[1253]: info: FusionDsp - Clipping Monitor started Jun 08 01:46:12 volumiopi5 volumio[1253]: info: FusionDsp - Clipping Monitor started Jun 08 01:46:15 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioGetState Jun 08 01:46:15 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:17 volumiopi5 volumio[1253]: info: Executing endpoint metavolumio Jun 08 01:46:17 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 01:46:17 volumiopi5 volumio[1253]: info: Executing endpoint metavolumio Jun 08 01:46:17 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 01:46:17 volumiopi5 volumio[1253]: info: Executing endpoint metavolumio Jun 08 01:46:17 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 01:46:23 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 08 01:46:23 volumiopi5 volumio[1253]: info: Received Get System Info Jun 08 01:46:23 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 08 01:46:23 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 08 01:46:23 volumiopi5 volumio[1253]: info: Discovery: Getting this device information Jun 08 01:46:23 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioGetState Jun 08 01:46:23 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:23 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 08 01:46:27 volumiopi5 systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 08 01:46:30 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioGetState Jun 08 01:46:30 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:32 volumiopi5 volumio[1253]: info: Executing endpoint metavolumio Jun 08 01:46:32 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 01:46:32 volumiopi5 volumio[1253]: info: Executing endpoint metavolumio Jun 08 01:46:32 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 01:46:32 volumiopi5 volumio[1253]: info: Executing endpoint metavolumio Jun 08 01:46:32 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 01:46:44 volumiopi5 volumio[1253]: info: Preload queue cleared Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreStateMachine::ClearQueue Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreStateMachine::stop Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreStateMachine::stPlaybackTimer Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreStateMachine::updateTrackBlock Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrackBlock Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreStateMachine::pushState Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushState Jun 08 01:46:44 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output update for this device Jun 08 01:46:44 volumiopi5 volumio[1253]: info: MRS: Pushing multiroomSync output Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreStateMachine::serviceStop Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CorePlayQueue::getTrack 0 Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreCommandRouter::serviceStop Jun 08 01:46:44 volumiopi5 volumio[1253]: info: ControllerMpd::stop Jun 08 01:46:44 volumiopi5 volumio[1253]: verbose: ControllerMpd::sendMpdCommand stop Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CorePlayQueue::clearPlayQueue Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CorePlayQueue::saveQueue Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushQueue Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CoreStateMachine::addQueueItems Jun 08 01:46:44 volumiopi5 volumio[1253]: info: CorePlayQueue::addQueueItems Jun 08 01:46:44 volumiopi5 volumio[1253]: info: Preload queue cleared Jun 08 01:46:44 volumiopi5 volumio[1253]: info: Adding Item to queue: music-library/USB/Music/Song Jun 08 01:46:44 volumiopi5 volumio[1253]: info: Exploding uri music-library/USB/Music/Song in service mpd Jun 08 01:46:45 volumiopi5 volumio[1253]: info: Preload queue cleared Jun 08 01:46:45 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 08 01:46:45 volumiopi5 volumio[1253]: info: CoreStateMachine::ClearQueue Jun 08 01:46:45 volumiopi5 volumio[1253]: info: CoreStateMachine::stop Jun 08 01:46:45 volumiopi5 volumio[1253]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 08 01:46:45 volumiopi5 volumio[1253]: info: CorePlayQueue::clearPlayQueue Jun 08 01:46:45 volumiopi5 volumio[1253]: info: CorePlayQueue::saveQueue Jun 08 01:46:45 volumiopi5 volumio[1253]: info: CoreCommandRouter::volumioPushQueue Jun 08 01:46:45 volumiopi5 volumio[1253]: info: CoreStateMachine::addQueueItems Jun 08 01:46:45 volumiopi5 volumio[1253]: info: CorePlayQueue::addQueueItems Jun 08 01:46:45 volumiopi5 volumio[1253]: info: Preload queue cleared Jun 08 01:46:45 volumiopi5 volumio[1253]: info: Adding Item to queue: music-library/USB/Music/Song Jun 08 01:46:45 volumiopi5 volumio[1253]: info: Exploding uri music-library/USB/Music/Song in service mpd Jun 08 01:46:45 volumiopi5 volumio[1253]: info: FusionDsp - Volumio is not playing Jun 08 01:46:45 volumiopi5 volumio[1253]: info: FusionDsp - Clipped samples monitor stopped Jun 08 01:46:45 volumiopi5 volumio[1253]: info: Jun 08 01:46:45 volumiopi5 volumio[1253]: ---------------------------- MPD announces state update: player Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F01.%20Desperado.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/01. Desperado.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F02.%20What%20a%20Wonderful%20World.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/02. What a Wonderful World.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F03.%20What%20the%20World%20Needs%20Now%20Is%20Love.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/03. What the World Needs Now Is Love.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F04.%20Perhaps%20Love.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/04. Perhaps Love.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F05.%20Fly%20Away.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/05. Fly Away.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F06.%20You%20Don%E2%80%99t%20Bring%20Me%20Flowers.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/06. You Don’t Bring Me Flowers.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F07.%20Fields%20of%20Gold.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/07. Fields of Gold.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F08.%20Marisa.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/08. Marisa.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F09.%20Over%20the%20Rainbow.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/09. Over the Rainbow.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F10.%20Better%20Be%20Home%20Soon.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/10. Better Be Home Soon.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F11.%20If.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/11. If.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F12.%20I%20Left%20My%20Heart%20in%20San%20Francisco.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/12. I Left My Heart in San Francisco.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F13.%20When%20I%20Dream.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/13. When I Dream.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F14.%20When%20You%20Say%20Nothing%20at%20All.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/14. When You Say Nothing at All.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=//extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2F15.%20The%20Look%20of%20Love.wav&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/15. The Look of Love.wav Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=%E8%97%A4%E7%94%B0%E6%81%B5%E7%BE%8E/Best%20Audiophile%20Voices%20Selection/extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2FVarious%20Artists%20-%20Best%20Audiophile%20Voices%20Selection.cue&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/Various Artists - Best Audiophile Voices Selection.cue Jun 08 01:46:45 volumiopi5 volumio[1253]: info: ALBUMART /albumart?cacheid=352&web=Eva%20Cassidy/Best%20Audiophile%20Voices%20Selection/extralarge&path=%2Fmnt%2FUSB%2FMusic%2FSong%2F2006%20-%20Best%20Audiophile%20Voices%20Selection%20(SG%20-%20Premium%20Records%20PR27905%20-%202006)%2FVarious%20Artists%20-%20Best%20Audiophile%20Voices%20Selection.cue&metadata=false Jun 08 01:46:45 volumiopi5 volumio[1253]: info: URI /mnt/USB/Music/Song/2006 - Best Audiophile Voices Selection (SG - Premium Records PR27905 - 2006)/Various Artists - Best Audiophile Voices Selection.cue Jun 08 01:46:45 volumiopi5 volumio[1253]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 08 01:46:45 volumiopi5 volumio[1253]: Error: Unable to resolve or reject the same promise twice Jun 08 01:46:45 volumiopi5 volumio[1253]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jun 08 01:46:45 volumiopi5 volumio[1253]: at /volumio/app/plugins/music_service/mpd/index.js:2569:21 Jun 08 01:46:45 volumiopi5 volumio[1253]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jun 08 01:46:45 volumiopi5 volumio[1253]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jun 08 01:46:45 volumiopi5 volumio[1253]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jun 08 01:46:45 volumiopi5 volumio[1253]: at Socket.emit (node:events:514:28) Jun 08 01:46:45 volumiopi5 volumio[1253]: at addChunk (node:internal/streams/readable:343:12) Jun 08 01:46:45 volumiopi5 volumio[1253]: at readableAddChunk (node:internal/streams/readable:312:11) Jun 08 01:46:45 volumiopi5 volumio[1253]: at Readable.push (node:internal/streams/readable:253:10) Jun 08 01:46:45 volumiopi5 volumio[1253]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Jun 08 01:46:45 volumiopi5 volumio[1253]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 08 01:46:45 volumiopi5 sudo[18309]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-08 01:45' Jun 08 01:46:45 volumiopi5 sudo[18309]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4a70cb031e64a8e498efc3e29470650871ff7d54" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Jun 2 12:57:40 UTC 2025" VOLUMIO_VERSION="4.008" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4256517ba770cec8e56a1795de23dd16"