-- Logs begin at Thu 2019-02-14 07:11:59 -03, end at Fri 2024-11-01 03:37:10 -03. -- Nov 01 03:36:39 volumio ntpd[774]: receive: Unexpected origin timestamp 0xea9419dd.c788eb53 does not match aorg 0000000000.00000000 from server@200.89.75.198 xmt 0xeacef577.62c1de18 Nov 01 03:36:39 volumio systemd[1]: Starting Daily apt download activities... Nov 01 03:36:39 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 03:36:39 volumio volumio[961]: info: CURURI: music-library/INTERNAL Nov 01 03:36:39 volumio volumio[961]: info: Preload queue cleared Nov 01 03:36:40 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 03:36:40 volumio volumio[961]: info: CURURI: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival Nov 01 03:36:40 volumio volumio[961]: info: Preload queue cleared Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-02 - Pretty Boy.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-03 - Council Skies.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-04 - We're Gonna Get There in the End.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-05 - Open the Door, See What You Find.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-06 - You Know We Can't Go Back.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-07 - We're on Our Way Now.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-08 - In the Heat of the Moment.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-09 - If I Had a Gun... .flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-10 - AKA... What a Life!.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-11 - Dead in the Water.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-12 - Going Nowhere.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-13 - Talk Tonight.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-14 - Whatever.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-15 - Half the World Away.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-16 - The Masterplan.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-18 - Love Will Tear Us Apart.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-19 - Stand by Me.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-20 - Live Forever.flac Nov 01 03:36:40 volumio volumio[961]: info: Preloading song: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-21 - Don't Look Back in Anger.flac Nov 01 03:36:40 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-02 - Pretty Boy.flac in service mpd Nov 01 03:36:40 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-02%20-%20Pretty%20Boy.flac&metadata=false Nov 01 03:36:40 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-02 - Pretty Boy.flac Nov 01 03:36:40 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-03 - Council Skies.flac in service mpd Nov 01 03:36:40 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-03%20-%20Council%20Skies.flac&metadata=false Nov 01 03:36:40 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-03 - Council Skies.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-04 - We're Gonna Get There in the End.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-04%20-%20We're%20Gonna%20Get%20There%20in%20the%20End.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-04 - We're Gonna Get There in the End.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-05 - Open the Door, See What You Find.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-05%20-%20Open%20the%20Door%2C%20See%20What%20You%20Find.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-05 - Open the Door, See What You Find.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-06 - You Know We Can't Go Back.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-06%20-%20You%20Know%20We%20Can't%20Go%20Back.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-06 - You Know We Can't Go Back.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-07 - We're on Our Way Now.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-07%20-%20We're%20on%20Our%20Way%20Now.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-07 - We're on Our Way Now.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-08 - In the Heat of the Moment.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-08%20-%20In%20the%20Heat%20of%20the%20Moment.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-08 - In the Heat of the Moment.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-09 - If I Had a Gun... .flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-09%20-%20If%20I%20Had%20a%20Gun...%20.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-09 - If I Had a Gun... .flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-10 - AKA... What a Life!.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-10%20-%20AKA...%20What%20a%20Life!.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-10 - AKA... What a Life!.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-11 - Dead in the Water.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-11%20-%20Dead%20in%20the%20Water.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-11 - Dead in the Water.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-12 - Going Nowhere.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-12%20-%20Going%20Nowhere.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-12 - Going Nowhere.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-13 - Talk Tonight.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-13%20-%20Talk%20Tonight.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-13 - Talk Tonight.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-14 - Whatever.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-14%20-%20Whatever.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-14 - Whatever.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-15 - Half the World Away.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-15%20-%20Half%20the%20World%20Away.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-15 - Half the World Away.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-16 - The Masterplan.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-16%20-%20The%20Masterplan.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-16 - The Masterplan.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-17%20-%20Little%20by%20Little.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-18 - Love Will Tear Us Apart.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-18%20-%20Love%20Will%20Tear%20Us%20Apart.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-18 - Love Will Tear Us Apart.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-19 - Stand by Me.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-19%20-%20Stand%20by%20Me.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-19 - Stand by Me.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-20 - Live Forever.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-20%20-%20Live%20Forever.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-20 - Live Forever.flac Nov 01 03:36:41 volumio volumio[961]: info: Exploding uri music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-21 - Don't Look Back in Anger.flac in service mpd Nov 01 03:36:41 volumio volumio[961]: info: ALBUMART /albumart?cacheid=513&web=Noel%20Gallagher's%20High%20Flying%20Birds/2024-07-28%20-%20Fuji%20Rock%20Festival%20%5Bflac%5D%20sbd_web%5D%20-%20asithappens/extralarge&path=%2Fmnt%2FINTERNAL%2FNGHFB%20-%202024-07-28%20-%20Fuji%20Rock%20Festival%2F1-21%20-%20Don't%20Look%20Back%20in%20Anger.flac&metadata=false Nov 01 03:36:41 volumio volumio[961]: info: URI /mnt/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-21 - Don't Look Back in Anger.flac Nov 01 03:36:42 volumio systemd[1]: apt-daily.service: Succeeded. Nov 01 03:36:42 volumio systemd[1]: Started Daily apt download activities. Nov 01 03:36:42 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Nov 01 03:36:42 volumio volumio[961]: info: Preload queue cleared Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::ClearQueue Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::stop Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::clearPlayQueue Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::saveQueue Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPushQueue Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::addQueueItems Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::addQueueItems Nov 01 03:36:42 volumio volumio[961]: info: Preload queue cleared Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-02 - Pretty Boy.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-02 - Pretty Boy.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-03 - Council Skies.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-03 - Council Skies.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-04 - We're Gonna Get There in the End.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-04 - We're Gonna Get There in the End.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-05 - Open the Door, See What You Find.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-05 - Open the Door, See What You Find.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-06 - You Know We Can't Go Back.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-06 - You Know We Can't Go Back.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-07 - We're on Our Way Now.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-07 - We're on Our Way Now.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-08 - In the Heat of the Moment.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-08 - In the Heat of the Moment.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-09 - If I Had a Gun... .flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-09 - If I Had a Gun... .flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-10 - AKA... What a Life!.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-10 - AKA... What a Life!.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-11 - Dead in the Water.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-11 - Dead in the Water.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-12 - Going Nowhere.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-12 - Going Nowhere.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-13 - Talk Tonight.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-13 - Talk Tonight.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-14 - Whatever.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-14 - Whatever.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-15 - Half the World Away.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-15 - Half the World Away.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-16 - The Masterplan.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-16 - The Masterplan.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-18 - Love Will Tear Us Apart.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-18 - Love Will Tear Us Apart.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-19 - Stand by Me.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-19 - Stand by Me.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-20 - Live Forever.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-20 - Live Forever.flac Nov 01 03:36:42 volumio volumio[961]: info: Adding Item to queue: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-21 - Don't Look Back in Anger.flac Nov 01 03:36:42 volumio volumio[961]: info: Using cached record of: music-library/INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-21 - Don't Look Back in Anger.flac Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPushQueue Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::saveQueue Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::updateTrackBlock Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrackBlock Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPlay Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::play index 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::stop Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::play index undefined Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::startPlaybackTimer Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand stop took 1 milliseconds Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 03:36:42 volumio volumio[961]: info: Nov 01 03:36:42 volumio volumio[961]: ---------------------------- MPD announces system playlist update Nov 01 03:36:42 volumio volumio[961]: info: Ignoring MPD Status Update Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand clear took 1 milliseconds Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac" Nov 01 03:36:42 volumio volumio[961]: info: Nov 01 03:36:42 volumio volumio[961]: ---------------------------- MPD announces system playlist update Nov 01 03:36:42 volumio volumio[961]: info: Ignoring MPD Status Update Nov 01 03:36:42 volumio volumio[961]: info: Nov 01 03:36:42 volumio volumio[961]: ---------------------------- MPD announces system playlist update Nov 01 03:36:42 volumio volumio[961]: info: Ignoring MPD Status Update Nov 01 03:36:42 volumio volumio[961]: error: updateQueue error: null Nov 01 03:36:42 volumio volumio[961]: info: Nov 01 03:36:42 volumio volumio[961]: ---------------------------- MPD announces system playlist update Nov 01 03:36:42 volumio volumio[961]: info: Ignoring MPD Status Update Nov 01 03:36:42 volumio volumio[961]: info: ------------------------------ 5ms Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand add "INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac" took 5 milliseconds Nov 01 03:36:42 volumio volumio[961]: info: ------------------------------ 4ms Nov 01 03:36:42 volumio volumio[961]: info: ------------------------------ 3ms Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand play Nov 01 03:36:42 volumio volumio[961]: info: Nov 01 03:36:42 volumio volumio[961]: ---------------------------- MPD announces system playlist update Nov 01 03:36:42 volumio volumio[961]: info: Ignoring MPD Status Update Nov 01 03:36:42 volumio volumio[961]: info: Nov 01 03:36:42 volumio volumio[961]: ---------------------------- MPD announces system playlist update Nov 01 03:36:42 volumio volumio[961]: info: Ignoring MPD Status Update Nov 01 03:36:42 volumio volumio[961]: info: Nov 01 03:36:42 volumio volumio[961]: ---------------------------- MPD announces state update: player Nov 01 03:36:42 volumio volumio[961]: info: ------------------------------ 7ms Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand play took 4 milliseconds Nov 01 03:36:42 volumio volumio[961]: info: ------------------------------ 4ms Nov 01 03:36:42 volumio volumio[961]: info: ControllerMpd::getState Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand status Nov 01 03:36:42 volumio volumio[961]: info: Nov 01 03:36:42 volumio volumio[961]: ---------------------------- MPD announces state update: player Nov 01 03:36:42 volumio volumio[961]: info: ControllerMpd::getState Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand status Nov 01 03:36:42 volumio volumio[961]: info: Nov 01 03:36:42 volumio volumio[961]: ---------------------------- MPD announces state update: player Nov 01 03:36:42 volumio volumio[961]: info: ControllerMpd::getState Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand status Nov 01 03:36:42 volumio volumio[961]: info: ------------------------------ 7ms Nov 01 03:36:42 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Nov 01 03:36:42 volumio volumio[961]: info: Nov 01 03:36:42 volumio volumio[961]: ---------------------------- MPD announces state update: player Nov 01 03:36:42 volumio volumio[961]: info: ControllerMpd::getState Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand status Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand status took 18 milliseconds Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand status took 17 milliseconds Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand status took 16 milliseconds Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::parseState Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::parseState Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::parseState Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 03:36:42 volumio volumio[961]: info: Nov 01 03:36:42 volumio volumio[961]: ---------------------------- MPD announces state update: player Nov 01 03:36:42 volumio volumio[961]: info: ControllerMpd::getState Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand status Nov 01 03:36:42 volumio volumio[961]: info: Nov 01 03:36:42 volumio volumio[961]: ---------------------------- MPD announces state update: player Nov 01 03:36:42 volumio volumio[961]: info: ControllerMpd::getState Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand status Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand status took 13 milliseconds Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand status took 10 milliseconds Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand status took 4 milliseconds Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::parseState Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::parseTrackInfo Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::parseTrackInfo Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::parseTrackInfo Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::parseState Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::parseState Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 03:36:42 volumio volumio[961]: info: ControllerMpd::pushState Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::servicePushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":292,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Little by Little","artist":"Noel Gallagher's High Flying Birds","album":"2024-07-28 - Fuji Rock Festival [flac] sbd_web] - asithappens","uri":"INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac","trackType":"flac"} Nov 01 03:36:42 volumio volumio[961]: verbose: CURRENT POSITION 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::syncState stateService play Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::syncState currentStatus stop Nov 01 03:36:42 volumio volumio[961]: info: ControllerMpd::pushState Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::servicePushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":292,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Little by Little","artist":"Noel Gallagher's High Flying Birds","album":"2024-07-28 - Fuji Rock Festival [flac] sbd_web] - asithappens","uri":"INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac","trackType":"flac"} Nov 01 03:36:42 volumio volumio[961]: verbose: CURRENT POSITION 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::syncState stateService play Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::syncState currentStatus play Nov 01 03:36:42 volumio volumio[961]: info: Received an update from plugin. extracting info from payload Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:42 volumio volumio[961]: info: ControllerMpd::pushState Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::servicePushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":292,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Little by Little","artist":"Noel Gallagher's High Flying Birds","album":"2024-07-28 - Fuji Rock Festival [flac] sbd_web] - asithappens","uri":"INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac","trackType":"flac"} Nov 01 03:36:42 volumio volumio[961]: verbose: CURRENT POSITION 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::syncState stateService play Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::syncState currentStatus play Nov 01 03:36:42 volumio volumio[961]: info: Received an update from plugin. extracting info from payload Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:42 volumio volumio[961]: info: ------------------------------ 57ms Nov 01 03:36:42 volumio volumio[961]: info: ------------------------------ 71ms Nov 01 03:36:42 volumio volumio[961]: info: ------------------------------ 71ms Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand playlistinfo took 40 milliseconds Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand playlistinfo took 39 milliseconds Nov 01 03:36:42 volumio volumio[961]: info: sendMpdCommand playlistinfo took 38 milliseconds Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::parseTrackInfo Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::parseTrackInfo Nov 01 03:36:42 volumio volumio[961]: verbose: ControllerMpd::parseTrackInfo Nov 01 03:36:42 volumio volumio[961]: info: ControllerMpd::pushState Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::servicePushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: verbose: STATE SERVICE {"status":"play","position":0,"seek":966,"duration":292,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"814 Kbps","isStreaming":false,"title":"Little by Little","artist":"Noel Gallagher's High Flying Birds","album":"2024-07-28 - Fuji Rock Festival [flac] sbd_web] - asithappens","uri":"INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac","trackType":"flac"} Nov 01 03:36:42 volumio volumio[961]: verbose: CURRENT POSITION 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::syncState stateService play Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::syncState currentStatus play Nov 01 03:36:42 volumio volumio[961]: info: Received an update from plugin. extracting info from payload Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:42 volumio volumio[961]: info: ControllerMpd::pushState Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::servicePushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: verbose: STATE SERVICE {"status":"play","position":0,"seek":966,"duration":292,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"814 Kbps","isStreaming":false,"title":"Little by Little","artist":"Noel Gallagher's High Flying Birds","album":"2024-07-28 - Fuji Rock Festival [flac] sbd_web] - asithappens","uri":"INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac","trackType":"flac"} Nov 01 03:36:42 volumio volumio[961]: verbose: CURRENT POSITION 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::syncState stateService play Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::syncState currentStatus play Nov 01 03:36:42 volumio volumio[961]: info: Received an update from plugin. extracting info from payload Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:42 volumio volumio[961]: info: ControllerMpd::pushState Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::servicePushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: verbose: STATE SERVICE {"status":"play","position":0,"seek":966,"duration":292,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"753 Kbps","isStreaming":false,"title":"Little by Little","artist":"Noel Gallagher's High Flying Birds","album":"2024-07-28 - Fuji Rock Festival [flac] sbd_web] - asithappens","uri":"INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac","trackType":"flac"} Nov 01 03:36:42 volumio volumio[961]: verbose: CURRENT POSITION 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::syncState stateService play Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::syncState currentStatus play Nov 01 03:36:42 volumio volumio[961]: info: Received an update from plugin. extracting info from payload Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:42 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:42 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:42 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:42 volumio volumio[961]: info: ------------------------------ 95ms Nov 01 03:36:42 volumio volumio[961]: info: ------------------------------ 89ms Nov 01 03:36:42 volumio volumio[961]: info: ------------------------------ 89ms Nov 01 03:36:43 volumio volumio[961]: info: Discovery: A device disappeared from network Nov 01 03:36:43 volumio volumio[961]: info: Discovery: Device volumio disappeared from network Nov 01 03:36:43 volumio volumio[961]: info: Discovery: adding 3fe7a977-8b26-4c7a-bc31-add8b9ec2a7f Nov 01 03:36:43 volumio volumio[961]: info: Discovery: Found device Volumio Nov 01 03:36:43 volumio volumio[961]: info: CoreCommandRouter::volumioGetState Nov 01 03:36:43 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:43 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Nov 01 03:36:43 volumio systemd[1]: Started Daily apt upgrade and clean activities. Nov 01 03:36:47 volumio volumio[961]: info: CoreCommandRouter::volumioPause Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::pause Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::stPlaybackTimer Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::servicePause Nov 01 03:36:47 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:47 volumio volumio[961]: info: CoreCommandRouter::servicePause Nov 01 03:36:47 volumio volumio[961]: info: ControllerMpd::pause Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand pause Nov 01 03:36:47 volumio volumio[961]: info: sendMpdCommand pause took 1 milliseconds Nov 01 03:36:47 volumio volumio[961]: info: Nov 01 03:36:47 volumio volumio[961]: ---------------------------- MPD announces state update: player Nov 01 03:36:47 volumio volumio[961]: info: ControllerMpd::getState Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand status Nov 01 03:36:47 volumio volumio[961]: info: Nov 01 03:36:47 volumio volumio[961]: ---------------------------- MPD announces state update: player Nov 01 03:36:47 volumio volumio[961]: info: ControllerMpd::getState Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand status Nov 01 03:36:47 volumio volumio[961]: info: Nov 01 03:36:47 volumio volumio[961]: ---------------------------- MPD announces state update: player Nov 01 03:36:47 volumio volumio[961]: info: ControllerMpd::getState Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand status Nov 01 03:36:47 volumio volumio[961]: info: sendMpdCommand status took 3 milliseconds Nov 01 03:36:47 volumio volumio[961]: info: sendMpdCommand status took 2 milliseconds Nov 01 03:36:47 volumio volumio[961]: info: sendMpdCommand status took 1 milliseconds Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::parseState Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::parseState Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::parseState Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 03:36:47 volumio volumio[961]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 03:36:47 volumio volumio[961]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 01 03:36:47 volumio volumio[961]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::parseTrackInfo Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::parseTrackInfo Nov 01 03:36:47 volumio volumio[961]: verbose: ControllerMpd::parseTrackInfo Nov 01 03:36:47 volumio volumio[961]: info: ControllerMpd::pushState Nov 01 03:36:47 volumio volumio[961]: info: CoreCommandRouter::servicePushState Nov 01 03:36:47 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:47 volumio volumio[961]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5339,"duration":292,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"708 Kbps","isStreaming":false,"title":"Little by Little","artist":"Noel Gallagher's High Flying Birds","album":"2024-07-28 - Fuji Rock Festival [flac] sbd_web] - asithappens","uri":"INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac","trackType":"flac"} Nov 01 03:36:47 volumio volumio[961]: verbose: CURRENT POSITION 15 Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::syncState stateService pause Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::syncState currentStatus pause Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:47 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:47 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 03:36:47 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::stPlaybackTimer Nov 01 03:36:47 volumio volumio[961]: info: ControllerMpd::pushState Nov 01 03:36:47 volumio volumio[961]: info: CoreCommandRouter::servicePushState Nov 01 03:36:47 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:47 volumio volumio[961]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5339,"duration":292,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"708 Kbps","isStreaming":false,"title":"Little by Little","artist":"Noel Gallagher's High Flying Birds","album":"2024-07-28 - Fuji Rock Festival [flac] sbd_web] - asithappens","uri":"INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac","trackType":"flac"} Nov 01 03:36:47 volumio volumio[961]: verbose: CURRENT POSITION 15 Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::syncState stateService pause Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::syncState currentStatus pause Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:47 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:47 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::stPlaybackTimer Nov 01 03:36:47 volumio volumio[961]: info: ControllerMpd::pushState Nov 01 03:36:47 volumio volumio[961]: info: CoreCommandRouter::servicePushState Nov 01 03:36:47 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:47 volumio volumio[961]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":5339,"duration":292,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"708 Kbps","isStreaming":false,"title":"Little by Little","artist":"Noel Gallagher's High Flying Birds","album":"2024-07-28 - Fuji Rock Festival [flac] sbd_web] - asithappens","uri":"INTERNAL/NGHFB - 2024-07-28 - Fuji Rock Festival/1-17 - Little by Little.flac","trackType":"flac"} Nov 01 03:36:47 volumio volumio[961]: verbose: CURRENT POSITION 15 Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::syncState stateService pause Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::syncState currentStatus pause Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::pushState Nov 01 03:36:47 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:47 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Nov 01 03:36:47 volumio volumio[961]: info: CoreStateMachine::stPlaybackTimer Nov 01 03:36:47 volumio volumio[961]: info: ------------------------------ 24ms Nov 01 03:36:47 volumio volumio[961]: info: ------------------------------ 23ms Nov 01 03:36:47 volumio volumio[961]: info: ------------------------------ 22ms Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 01 03:36:47 volumio volumio[961]: info: Adding plugin bluetooth to MyMusic Plugins Nov 01 03:36:47 volumio volumio[961]: info: Adding plugin multiroom to MyMusic Plugins Nov 01 03:36:47 volumio volumio[961]: info: Adding plugin metavolumio to MyMusic Plugins Nov 01 03:36:47 volumio volumio[961]: info: Adding plugin cd_controller to MyMusic Plugins Nov 01 03:36:47 volumio volumio[961]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 01 03:36:47 volumio volumio[961]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 01 03:36:47 volumio volumio[961]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 01 03:36:48 volumio volumio[961]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 01 03:36:48 volumio volumio[961]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 01 03:36:48 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:48 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:48 volumio volumio[961]: info: Starting MyVolumio Remote Streaming Endpoints Nov 01 03:36:48 volumio volumio[961]: info: MyVolumio login type: Token Nov 01 03:36:48 volumio volumio[961]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 01 03:36:48 volumio volumio[961]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 01 03:36:49 volumio volumio[961]: info: Starting Streaming Service Transparent Proxy Nov 01 03:36:49 volumio volumio[961]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 01 03:36:49 volumio volumio[961]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 01 03:36:49 volumio volumio[961]: info: Streaming services startup Nov 01 03:36:49 volumio volumio[961]: info: Starting Streaming Daemon Nov 01 03:36:49 volumio sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 01 03:36:49 volumio sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 03:36:49 volumio sudo[1436]: pam_unix(sudo:session): session closed for user root Nov 01 03:36:49 volumio volumio[961]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 01 03:36:49 volumio volumio[961]: error: Cannot start Volumio Streaming Daemon Nov 01 03:36:49 volumio volumio[961]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 01 03:36:49 volumio volumio[961]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 01 03:36:49 volumio volumio[961]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Nov 01 03:36:50 volumio volumio[961]: STREAMING PROXY: Starting server on port 3245 Nov 01 03:36:50 volumio volumio[961]: Node JS runtime: 14 Nov 01 03:36:51 volumio volumio[961]: info: MyVolumio token set successfully Nov 01 03:36:51 volumio volumio[961]: info: MYVOLUMIO: Adding device Nov 01 03:36:51 volumio volumio[961]: info: MYVOLUMIO: Evaluating Server Nov 01 03:36:51 volumio volumio[961]: info: MyVolumio status changed Nov 01 03:36:51 volumio volumio[961]: info: Streaming services startup Nov 01 03:36:51 volumio volumio[961]: info: Starting Streaming Daemon Nov 01 03:36:51 volumio volumio[961]: info: Removing browser output: myVolumio user plan is not superstar Nov 01 03:36:51 volumio volumio[961]: info: Removing audio output: Nov 01 03:36:51 volumio volumio[961]: info: Stoppping Tunnel 1 Nov 01 03:36:51 volumio sudo[1462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 01 03:36:51 volumio sudo[1462]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 03:36:51 volumio sudo[1462]: pam_unix(sudo:session): session closed for user root Nov 01 03:36:51 volumio sudo[1465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Nov 01 03:36:51 volumio volumio[961]: error: Cannot start Volumio Streaming Daemon Nov 01 03:36:51 volumio volumio[961]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 01 03:36:51 volumio volumio[961]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 01 03:36:51 volumio sudo[1465]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 03:36:51 volumio sudo[1465]: pam_unix(sudo:session): session closed for user root Nov 01 03:36:51 volumio volumio[961]: info: Remote SSH Stopped Nov 01 03:36:52 volumio volumio[961]: info: Setting Geolocation for MyVolumio to us1 Nov 01 03:36:52 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:52 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:52 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:52 volumio volumio[961]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 01 03:36:53 volumio volumio[961]: info: Updating MyVolumio device info Nov 01 03:36:53 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:53 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:53 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:53 volumio volumio[961]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 01 03:36:53 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 03:36:53 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 03:36:53 volumio volumio[961]: info: Discovery: Getting this device information Nov 01 03:36:53 volumio volumio[961]: info: CoreCommandRouter::volumioGetState Nov 01 03:36:53 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:36:53 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 03:36:54 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 01 03:36:54 volumio volumio[961]: info: Preload queue cleared Nov 01 03:36:56 volumio volumio[961]: info: MYVOLUMIO: Adding device Nov 01 03:36:56 volumio volumio[961]: info: MYVOLUMIO: Evaluating Server Nov 01 03:36:57 volumio volumio[961]: info: Setting Geolocation for MyVolumio to us1 Nov 01 03:36:57 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:57 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:57 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:57 volumio volumio[961]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 01 03:36:58 volumio volumio[961]: info: Updating MyVolumio device info Nov 01 03:36:58 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:58 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:58 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:36:58 volumio volumio[961]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 01 03:37:00 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 01 03:37:00 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 01 03:37:03 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 01 03:37:03 volumio volumio[961]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Nov 01 03:37:03 volumio volumio[961]: info: CoreCommandRouter::volumioGetState Nov 01 03:37:03 volumio volumio[961]: info: CorePlayQueue::getTrack 15 Nov 01 03:37:07 volumio volumio[961]: info: Enabling plugin fusiondsp Nov 01 03:37:07 volumio volumio[961]: info: Loading plugin "fusiondsp"... Nov 01 03:37:07 volumio volumio[961]: info: Preparing to generate the ALSA configuration file Nov 01 03:37:07 volumio volumio[961]: info: Asound.conf file unchanged, so no further update is needed Nov 01 03:37:07 volumio volumio[961]: info: Output device has changed, restarting MPD Nov 01 03:37:07 volumio sudo[1483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 01 03:37:07 volumio sudo[1483]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 03:37:07 volumio volumio[961]: info: Output device has changed, restarting Shairport Sync Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:37:07 volumio sudo[1483]: pam_unix(sudo:session): session closed for user root Nov 01 03:37:07 volumio sudo[1485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 01 03:37:07 volumio sudo[1485]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 03:37:07 volumio systemd[1]: Stopping Music Player Daemon... Nov 01 03:37:07 volumio volumio[961]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 01 03:37:07 volumio volumio[961]: info: PLUGIN START: fusiondsp Nov 01 03:37:07 volumio volumio[961]: info: Loading i18n strings for locale es Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: FusionDsp - mixtype--------------------- Hardware Nov 01 03:37:07 volumio volumio[961]: info: Preparing to generate the ALSA configuration file Nov 01 03:37:07 volumio volumio[961]: info: Done. Nov 01 03:37:07 volumio volumio[961]: info: MPD Permissions set Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: Asound.conf file unchanged, so no further update is needed Nov 01 03:37:07 volumio volumio[961]: info: Output device has changed, restarting MPD Nov 01 03:37:07 volumio systemd[1]: mpd.service: Succeeded. Nov 01 03:37:07 volumio systemd[1]: Stopped Music Player Daemon. Nov 01 03:37:07 volumio volumio[961]: info: Output device has changed, restarting Shairport Sync Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio sudo[1496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 01 03:37:07 volumio sudo[1496]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 03:37:07 volumio volumio[961]: info: MPD Permissions set Nov 01 03:37:07 volumio volumio[961]: info: Starting Shairport Sync Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio sudo[1496]: pam_unix(sudo:session): session closed for user root Nov 01 03:37:07 volumio systemd[1]: Starting Music Player Daemon... Nov 01 03:37:07 volumio sudo[1499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 01 03:37:07 volumio sudo[1499]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 03:37:07 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 01 03:37:07 volumio systemd[1]: mpd.service: Succeeded. Nov 01 03:37:07 volumio systemd[1]: Stopped Music Player Daemon. Nov 01 03:37:07 volumio sudo[1506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 01 03:37:07 volumio systemd[1]: Starting Music Player Daemon... Nov 01 03:37:07 volumio sudo[1506]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 03:37:07 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 01 03:37:07 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 01 03:37:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 01 03:37:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 01 03:37:07 volumio sudo[1506]: pam_unix(sudo:session): session closed for user root Nov 01 03:37:07 volumio sudo[1511]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 01 03:37:07 volumio sudo[1511]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 03:37:07 volumio sudo[1511]: pam_unix(sudo:session): session closed for user root Nov 01 03:37:08 volumio volumio[961]: info: Starting Shairport Sync Nov 01 03:37:08 volumio volumio[961]: info: Shairport-Sync Started Nov 01 03:37:08 volumio sudo[1519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 01 03:37:08 volumio sudo[1519]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 03:37:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 01 03:37:08 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 01 03:37:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 01 03:37:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 01 03:37:08 volumio sudo[1519]: pam_unix(sudo:session): session closed for user root Nov 01 03:37:08 volumio volumio[961]: info: Shairport-Sync Started Nov 01 03:37:08 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:08 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:08 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 01 03:37:08 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 01 03:37:08 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 01 03:37:08 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 01 03:37:08 volumio volumio[961]: info: CoreCommandRouter::volumioGetBrowseSources Nov 01 03:37:08 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 01 03:37:08 volumio mpd[1517]: Nov 01 03:37 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 01 03:37:08 volumio systemd[1]: Started Music Player Daemon. Nov 01 03:37:08 volumio sudo[1499]: pam_unix(sudo:session): session closed for user root Nov 01 03:37:08 volumio sudo[1485]: pam_unix(sudo:session): session closed for user root Nov 01 03:37:08 volumio volumio[961]: error: MPD error: The expression evaluated to a falsy value: Nov 01 03:37:08 volumio volumio[961]: assert.ok(self.idling) Nov 01 03:37:08 volumio volumio[961]: error: The expression evaluated to a falsy value: Nov 01 03:37:08 volumio volumio[961]: assert.ok(self.idling) Nov 01 03:37:08 volumio volumio[961]: error: updateQueue error: null Nov 01 03:37:09 volumio volumio[961]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Nov 01 03:37:09 volumio volumio[961]: info: camilladsp service started and running in background, instance 1 Nov 01 03:37:09 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 03:37:09 volumio volumio[961]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 01 03:37:09 volumio volumio[961]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 01 03:37:09 volumio volumio[961]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 01 03:37:09 volumio volumio[961]: info: FusionDsp loaded Nov 01 03:37:09 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 03:37:09 volumio sudo[1536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 01 03:37:09 volumio sudo[1536]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 03:37:09 volumio volumio[961]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 01 03:37:09 volumio volumio[961]: info: Adding Signal Path Element [object Object] Nov 01 03:37:09 volumio volumio[961]: info: Adding fusiondspeq DSP Signal Path Element Nov 01 03:37:09 volumio volumio[961]: info: FusionDsp - ---- installed callbackRead Nov 01 03:37:09 volumio volumio[961]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 03:37:09 volumio volumio[961]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Nov 01 03:37:09 volumio volumio[961]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Nov 01 03:37:09 volumio volumio[961]: at onErrorNT (internal/child_process.js:465:16) Nov 01 03:37:09 volumio volumio[961]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Nov 01 03:37:09 volumio volumio[961]: errno: -2, Nov 01 03:37:09 volumio volumio[961]: code: 'ENOENT', Nov 01 03:37:09 volumio volumio[961]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 01 03:37:09 volumio volumio[961]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 01 03:37:09 volumio volumio[961]: spawnargs: [ Nov 01 03:37:09 volumio volumio[961]: '-p', Nov 01 03:37:09 volumio volumio[961]: 9876, Nov 01 03:37:09 volumio volumio[961]: '-o', Nov 01 03:37:09 volumio volumio[961]: '/tmp/camilladsp.log', Nov 01 03:37:09 volumio volumio[961]: '-l', Nov 01 03:37:09 volumio volumio[961]: 'warn', Nov 01 03:37:09 volumio volumio[961]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 01 03:37:09 volumio volumio[961]: ] Nov 01 03:37:09 volumio volumio[961]: } Nov 01 03:37:09 volumio volumio[961]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 03:37:09 volumio systemd[1]: Started FusionDsp Daemon. Nov 01 03:37:09 volumio sudo[1536]: pam_unix(sudo:session): session closed for user root Nov 01 03:37:10 volumio systemd[1]: fusiondsp.service: Succeeded. Nov 01 03:37:10 volumio sudo[1548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-01 03:36 Nov 01 03:37:10 volumio sudo[1548]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"