-- Logs begin at Wed 2024-05-01 00:31:37 EDT, end at Wed 2024-05-01 18:43:38 EDT. -- May 01 18:42:00 volumioa volumio[8052]: STREAMING PROXY: Starting server on port 3245 May 01 18:42:00 volumioa volumio[8052]: Node JS runtime: 14 May 01 18:42:00 volumioa volumio[8052]: info: MyVolumio token set successfully May 01 18:42:00 volumioa volumio[8052]: info: MYVOLUMIO: Adding device May 01 18:42:00 volumioa volumio[8052]: info: MYVOLUMIO: Evaluating Server May 01 18:42:00 volumioa volumio[8052]: info: MyVolumio status changed May 01 18:42:00 volumioa volumio[8052]: info: Streaming services startup May 01 18:42:00 volumioa volumio[8052]: info: Starting Streaming Daemon May 01 18:42:00 volumioa volumio[8052]: info: Removing browser output: myVolumio user plan is not superstar May 01 18:42:00 volumioa volumio[8052]: info: Removing audio output: May 01 18:42:00 volumioa volumio[8052]: info: Stoppping Tunnel 1 May 01 18:42:00 volumioa sudo[8427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 01 18:42:00 volumioa sudo[8427]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:00 volumioa sudo[8427]: pam_unix(sudo:session): session closed for user root May 01 18:42:00 volumioa sudo[8430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service May 01 18:42:00 volumioa sudo[8430]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:00 volumioa volumio[8052]: error: Cannot start Volumio Streaming Daemon May 01 18:42:00 volumioa volumio[8052]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 01 18:42:00 volumioa volumio[8052]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 01 18:42:00 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 18:42:00 volumioa volumio[8052]: info: CURURI: music-library/NAS/Media May 01 18:42:00 volumioa sudo[8430]: pam_unix(sudo:session): session closed for user root May 01 18:42:00 volumioa volumio[8052]: info: Remote SSH Stopped May 01 18:42:00 volumioa volumio[8052]: info: Preload queue cleared May 01 18:42:01 volumioa volumio[8052]: info: Setting Geolocation for MyVolumio to us3 May 01 18:42:01 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:01 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:01 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:01 volumioa volumio[8052]: SPOTIFY: SETTING SPOTIFY VOLUME 20 May 01 18:42:01 volumioa volumio[8052]: info: Sending Spotify command with payload to local API: /player/volume May 01 18:42:01 volumioa volumio[8052]: error: Failed to send command to Spotify local API: /player/volume: Error: Internal Server Error May 01 18:42:01 volumioa volumio[8052]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} May 01 18:42:02 volumioa volumio[8052]: info: Updating MyVolumio device info May 01 18:42:02 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:02 volumioa volumio[8052]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} May 01 18:42:03 volumioa volumio[8052]: info: Preload queue cleared May 01 18:42:03 volumioa volumio[8052]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 18:42:03 volumioa volumio[8052]: info: CoreStateMachine::ClearQueue May 01 18:42:03 volumioa volumio[8052]: info: CoreStateMachine::stop May 01 18:42:03 volumioa volumio[8052]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 18:42:03 volumioa volumio[8052]: info: CorePlayQueue::clearPlayQueue May 01 18:42:03 volumioa volumio[8052]: info: CorePlayQueue::saveQueue May 01 18:42:03 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushQueue May 01 18:42:03 volumioa volumio[8052]: info: CoreStateMachine::addQueueItems May 01 18:42:03 volumioa volumio[8052]: info: CorePlayQueue::addQueueItems May 01 18:42:03 volumioa volumio[8052]: info: Preload queue cleared May 01 18:42:03 volumioa volumio[8052]: info: Adding Item to queue: music-library/NAS/Media/Movies May 01 18:42:03 volumioa volumio[8052]: info: Exploding uri music-library/NAS/Media/Movies in service mpd May 01 18:42:06 volumioa volumio[8052]: info: MYVOLUMIO: Adding device May 01 18:42:06 volumioa volumio[8052]: info: MYVOLUMIO: Evaluating Server May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2F12%20Strong%20(2018)%2F12%20Strong%20(2018).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2F21%20Jump%20Street%20(2012)%2F21%20Jump%20Street%20(2012).m4v&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/21 Jump Street (2012)/21 Jump Street (2012).m4v May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2F21%20and%20Over%20(2013)%2F21%20and%20Over%20(2013).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/21 and Over (2013)/21 and Over (2013).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2F22%20Jump%20Street%20(2014)%2F22%20Jump%20Street%20(2014).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/22 Jump Street (2014)/22 Jump Street (2014).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2F300%20Rise%20of%20an%20Empire%20(2014)%20%5B1080p%5D%2F300%20Rise%20of%20an%20Empire%20(2014).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/300 Rise of an Empire (2014) [1080p]/300 Rise of an Empire (2014).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2F6%20Ways%20to%20Die%20(2015)%2F6%20Ways%20to%20Die%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/6 Ways to Die (2015)/6 Ways to Die (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2F7%20Assassins%20(2014)%2F7%20Assassins%20(2014).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/7 Assassins (2014)/7 Assassins (2014).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2F7%20Cases%20(2015)%2F7%20Cases%202015.avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/7 Cases (2015)/7 Cases 2015.avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FA%20Bad%20Mom%20Christmas%20(2018)%2FA%20Bad%20Moms%20Christmas%20(2017).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/A Bad Mom Christmas (2018)/A Bad Moms Christmas (2017).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FA%20Dark%20Reflection%20(2015)%2FA%20Dark%20Reflection%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/A Dark Reflection (2015)/A Dark Reflection 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FA%20Fresh%20Start%20(2015)%2FA%20Fresh%20Start%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/A Fresh Start (2015)/A Fresh Start 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FA%20Little%20Chaos%20(2015)%2FA%20Little%20Chaos%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/A Little Chaos (2015)/A Little Chaos (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FA%20Million%20Ways%20To%20Die%20In%20The%20West%20(2014)%2FA%20Million%20Ways%20To%20Die%20In%20The%20West%20(2014).avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/A Million Ways To Die In The West (2014)/A Million Ways To Die In The West (2014).avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FA%20Million%20Ways%20To%20Die%20In%20The%20West%20(2014)%2FRARBG.com.avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/A Million Ways To Die In The West (2014)/RARBG.com.avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FA%20Royal%20Night%20Out%20(2015)%2FA%20Royal%20Night%20Out%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/A Royal Night Out (2015)/A Royal Night Out (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FA%20Simple%20Favor%20(2018)%2FA%20Simple%20Favor%20(2018).avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/A Simple Favor (2018)/A Simple Favor (2018).avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FA%20Wrinkle%20in%20Time%20(2018)%2FA%20Wrinkle%20in%20Time%20(2018).avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/A Wrinkle in Time (2018)/A Wrinkle in Time (2018).avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FA.A.G.%20(2015)%2FA.A.G.%20(2015).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/A.A.G. (2015)/A.A.G. (2015).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FA.C.O.D.%20(2013)%2FA.C.O.D.%20(2013).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/A.C.O.D. (2013)/A.C.O.D. (2013).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAbout%20Time%20(2014)%2FAbout%20Time%20(2014).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/About Time (2014)/About Time (2014).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAbraham%20Lincoln%20Vampire%20Hunter%20(2012)%2FAbraham%20Lincoln%20Vampire%20Hunter.mov&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Abraham Lincoln Vampire Hunter (2012)/Abraham Lincoln Vampire Hunter.mov May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAir%20(2015)%2FAir%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Air (2015)/Air (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAir%20(2015)%2FAir-%20(2015).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Air (2015)/Air- (2015).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAloha%20(2015)%2FAloha%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Aloha (2015)/Aloha (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAmerican%20Assassin%20(2017)%2FAmerican%20Assassin%20(2017).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/American Assassin (2017)/American Assassin (2017).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAmerican%20Bad%20Boy%202015%2FAmerican%20Bad%20Boy%202015.avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/American Bad Boy 2015/American Bad Boy 2015.avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAmerican%20Reunion%2FAmerican%20Reunion.m4v&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/American Reunion/American Reunion.m4v May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAmerican%20Under%20Dog%20(2021)%2FAmerican%20Underdog%20(2021)%20Putlocker%20-%20Movies%20and%20Series%20Putlo.mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/American Under Dog (2021)/American Underdog (2021) Putlocker - Movies and Series Putlo.mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAmnesiac%20(2015)%2FAmnesiac%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Amnesiac (2015)/Amnesiac (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAngel%20(2015)%2FAngel%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Angel (2015)/Angel (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAnna%20Karina%20(2013)%2FAnna%20Karina%20(2013).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Anna Karina (2013)/Anna Karina (2013).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAnnihilation%20(2018)%2FAnnihilation%20(2018).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Annihilation (2018)/Annihilation (2018).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAnt-Man%20(2015)%2FAnt-Man%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Ant-Man (2015)/Ant-Man (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAppetites%20(2015)%2FAppetites%20(2015).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Appetites (2015)/Appetites (2015).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAquaman%20and%20the%20Lost%20Kingdom%20(2023)%20%2FAquaman%20and%20the%20Lost%20Kingdom%20(2023)%20Putlocker%20-%20Movies%20and%20S.mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Aquaman and the Lost Kingdom (2023) /Aquaman and the Lost Kingdom (2023) Putlocker - Movies and S.mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAtomic%20Blonde%20%2FAtomic%20Blonde%20(2017).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Atomic Blonde /Atomic Blonde (2017).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAutomata%20(2014)%2FAutomata%20(2014).avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Automata (2014)/Automata (2014).avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FAvengers%20Infinity%20War%20(2018)%2FAvengers%20Infinity%20War%20(2018).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Avengers Infinity War (2018)/Avengers Infinity War (2018).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=Ripped%20by%20ELiTE//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBad%20Grandpa%20(2014)%2FBad%20Grandpa%20(2014).avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Bad Grandpa (2014)/Bad Grandpa (2014).avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBad%20Grandpa%20(2014)%2FBad%20Grandpa%20(2014).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Bad Grandpa (2014)/Bad Grandpa (2014).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBad%20Roomies%202015%2FBad%20Roomies%202015.mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Bad Roomies 2015/Bad Roomies 2015.mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBait%20(2015)%2FBait%20(2015).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Bait (2015)/Bait (2015).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBatman%20Unlimited%20Monster%20Mayhem%20(2015)%2FBatman%20Unlimited%20Monster%20Mayhem%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Batman Unlimited Monster Mayhem (2015)/Batman Unlimited Monster Mayhem (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBeautiful%20Creatures%20(2013)%2FBeautiful%20Creatures%20(2013).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Beautiful Creatures (2013)/Beautiful Creatures (2013).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBelieve%20(2014)%2FBelieve%20(2014).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Believe (2014)/Believe (2014).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBenji%20(2018)%2FBenji%20(2018).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Benji (2018)/Benji (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBig%20Sky%20(2015)%2FBig%20Sky%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Big Sky (2015)/Big Sky (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBlack%20Panther%20(2018)%2FBlack%20Panther%20(2018).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Black Panther (2018)/Black Panther (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBlack%20Widow%2FBlack.Widow.2021.1080p.WEB.H264-TIMECUT.mkv.mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Black Widow/Black.Widow.2021.1080p.WEB.H264-TIMECUT.mkv.mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBlade%20Runner%202049%20(2017)%2FBlade%20Runner%202049%20(2017).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Blade Runner 2049 (2017)/Blade Runner 2049 (2017).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBleeding%20Heart%202015%2FBleeding%20Heart%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Bleeding Heart 2015/Bleeding Heart 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBleeding%20Steel%20(2017)%2FBleeding%20Steel%20(2017).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Bleeding Steel (2017)/Bleeding Steel (2017).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBlue%20Beetle%20(2023)%2FBlue%20Beetle%20(2023).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Blue Beetle (2023)/Blue Beetle (2023).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBorg%20vs%20McEnroe%20(2017)%2FBorg%20vs%20McEnroe%20(2017).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Borg vs McEnroe (2017)/Borg vs McEnroe (2017).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBreathe%20(2017)%2FBreathe%20(2017).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Breathe (2017)/Breathe (2017).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FBrick%20Mansions%20(2014)%2FBrick%20Mansions%20(2014).avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Brick Mansions (2014)/Brick Mansions (2014).avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FCall%20Me%20King%20(2015)%2FCall%20Me%20King%20(2015).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Call Me King (2015)/Call Me King (2015).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FCall%20Me%20by%20Your%20name%20(2017)%2FCall%20Me%20By%20Your%20Name%20(2017).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Call Me by Your name (2017)/Call Me By Your Name (2017).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FCamp%20(2013)%2FCamp%20(2013).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Camp (2013)/Camp (2013).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FCaptain%20America%20The%20Winter%20Soldier%20(2014)%2FCaptain%20America%20The%20Winter%20Soldier%20(2014).avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Captain America The Winter Soldier (2014)/Captain America The Winter Soldier (2014).avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FCentral%20Intelligence%20(2016)%2FCentral%20Intelligence%20(2016).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Central Intelligence (2016)/Central Intelligence (2016).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FChasing%20Ice%20(2012)%2FChasing%20Ice%20(2012).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Chasing Ice (2012)/Chasing Ice (2012).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FChef%20(2014)%2FChef%20(2014).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Chef (2014)/Chef (2014).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FCinderella%20(2015)%2FCinderella%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Cinderella (2015)/Cinderella (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FCircle%202015%2FCircle%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Circle 2015/Circle 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FClub%20Life%20(2015)%2FClub%20Life%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Club Life (2015)/Club Life (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FColossal%20(2017)%2FColossal%20(2017).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Colossal (2017)/Colossal (2017).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FCop%20Car%20(2015)%2FCop%20Car%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Cop Car (2015)/Cop Car (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FCriminal%20Activities%202015%2FCriminal%20Activities%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Criminal Activities 2015/Criminal Activities 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FCuban%20Fury%20(2014)%2FCuban%20Fury%20(2014).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Cuban Fury (2014)/Cuban Fury (2014).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDC%20League%20of%20Super-Pets%20(2022)%2FDC%20League%20of%20Super-Pets%20(2022)%20Putlocker%20-%20Movies%20and%20Series.mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/DC League of Super-Pets (2022)/DC League of Super-Pets (2022) Putlocker - Movies and Series.mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDaddys%20Home%202%20(2017)%2FDaddys%20Home%202%20(2017).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Daddys Home 2 (2017)/Daddys Home 2 (2017).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDancer%20and%20the%20Dame%202015%2FDancer%20and%20the%20Dame%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Dancer and the Dame 2015/Dancer and the Dame 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDark%20Shadows%20(2012)%2FDark%20Shadows%20(2012).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Dark Shadows (2012)/Dark Shadows (2012).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDark%20Web%20(2016)%2FDark%20Web%20(2016).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Dark Web (2016)/Dark Web (2016).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDeadpool%202%20(2018)%2FDeadpool%202%20(2018).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Deadpool 2 (2018)/Deadpool 2 (2018).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDeath%20Wish%20(2018)%2FDeath%20Wish%20(2018).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Death Wish (2018)/Death Wish (2018).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDen%20of%20Thieves%20(2018)%2FDen%20of%20Thieves%20(2018).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Den of Thieves (2018)/Den of Thieves (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDescendants%202015%2FDescendants%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Descendants 2015/Descendants 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDespicable%20Me%203%20(2017)%2FDespicable%20Me%203%20(2017).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Despicable Me 3 (2017)/Despicable Me 3 (2017).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDestination%20Wedding%20(2018)%2FDestination%20Wedding%20(2018).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Destination Wedding (2018)/Destination Wedding (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDirty%20Grandpa%20(2017)%2FDirty%20Grandpa%20(2017).m4v&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Dirty Grandpa (2017)/Dirty Grandpa (2017).m4v May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDirty%20Weekend%202015%2FDirty%20Weekend%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Dirty Weekend 2015/Dirty Weekend 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDivergence%20(2014)%2FDivergence%20(2014).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Divergence (2014)/Divergence (2014).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDownsizing%20(2017)%2FDownsizing%20(2017).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Downsizing (2017)/Downsizing (2017).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDraft%20Day%20(2014)%2FDraft%20Day%20(2014).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Draft Day (2014)/Draft Day (2014).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FDunes%2FDune.2021.1080p.HDRip.X264-EVO.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Dunes/Dune.2021.1080p.HDRip.X264-EVO.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FEarth%20To%20Echo%20(2014)%2FEarth%20To%20Echo%20(2014).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Earth To Echo (2014)/Earth To Echo (2014).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FEdge%20of%20Tomorrow%20(2014)%2FEdge%20of%20Tomorrow%20(2014).avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Edge of Tomorrow (2014)/Edge of Tomorrow (2014).avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FEllis%202015%2FEllis%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Ellis 2015/Ellis 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FElvis%20(2022)%2FElvis.mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Elvis (2022)/Elvis.mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FEnders%20Game%20(2014)%2FEnders%20Game%20(2014).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Enders Game (2014)/Enders Game (2014).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FEntourage%20(2015)%2FEntourage%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Entourage (2015)/Entourage (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FEscape%20Plan%20(2014)%2FEscape%20Plan%20(2014).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Escape Plan (2014)/Escape Plan (2014).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FEvil%20Dead%20(2013)%2FEvil%20Dead%20(2013).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Evil Dead (2013)/Evil Dead (2013).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FEvil%20Dead%20II%20(1987)%2FEvil%20Dead%20II%20(1987).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Evil Dead II (1987)/Evil Dead II (1987).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FExposed%20(2016)%2FExposed%20(2016).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Exposed (2016)/Exposed (2016).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FExtinction%20(2018)%2FExtinction%20(2018).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Extinction (2018)/Extinction (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FFar%20from%20the%20Madding%20Crowd%202015%2FFar%20from%20the%20Madding%20Crowd%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Far from the Madding Crowd 2015/Far from the Madding Crowd 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FFast%20and%20Furious%20F9%2FFast.and.Furious.F9.The.Fast.Saga.2021.1080p.AMZN.WEB-DL.DDP5.1.Atmos.x264-NOGRP.mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Fast and Furious F9/Fast.and.Furious.F9.The.Fast.Saga.2021.1080p.AMZN.WEB-DL.DDP5.1.Atmos.x264-NOGRP.mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FFerdinand%20(2017)%2FFerdinand%20(2017).avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Ferdinand (2017)/Ferdinand (2017).avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FFifty%20Shades%20Freed%20(2018)%2FFifty%20Shades%20Freed%20(2018).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Fifty Shades Freed (2018)/Fifty Shades Freed (2018).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FFinal%20Girl%202015%2FFinal%20Girl%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Final Girl 2015/Final Girl 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FFirestarter%20(2022)%2FFirestarter%20(2022)%20Putlocker%20-%20Movies%20and%20Series%20Putlockers.mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Firestarter (2022)/Firestarter (2022) Putlocker - Movies and Series Putlockers.mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FFirst%20Man%20(2018)%2FFirst%20Man%20(2018).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/First Man (2018)/First Man (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FFlatliners%20(2017)%2FFlatliners%20(2017).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Flatliners (2017)/Flatliners (2017).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FForeign%20Land%20(2016)%2FForeign%20Land%20(2016).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Foreign Land (2016)/Foreign Land (2016).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FForever%20My%20Girl%20(2018)%2FForever%20My%20Girl%20%20(2018).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Forever My Girl (2018)/Forever My Girl (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FFullMetal%20Alchemist%20(2017)%2FFullMetal%20Alchemist%20(2017).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/FullMetal Alchemist (2017)/FullMetal Alchemist (2017).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FG.I.%20Joe%20Retaliation%20(2013)%2FG.I.%20Joe%20Retaliation%20(2013).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/G.I. Joe Retaliation (2013)/G.I. Joe Retaliation (2013).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FG.P.%20(2014)%2FG.P.%20(2014).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/G.P. (2014)/G.P. (2014).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FGame%20Night%20(2018)%2FGame%20Night%20(2018).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Game Night (2018)/Game Night (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FGame%20Over%20Man%20(2018)%2FGame%20Over%20Man%20(2018).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Game Over Man (2018)/Game Over Man (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FGenie%20in%20a%20Bikini%20(2015)%2FGenie%20in%20a%20Bikini%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Genie in a Bikini (2015)/Genie in a Bikini (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FGeostorm%20(2017)%2FGeostorm%20(2017).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Geostorm (2017)/Geostorm (2017).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FGet%20Out%20(2017)%2FGet%20Out%20(2017).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Get Out (2017)/Get Out (2017).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FGhosts%202015%2FGhosts%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Ghosts 2015/Ghosts 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FGifted%20(2017)%2FGifted%20(2017).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Gifted (2017)/Gifted (2017).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FGirl%20Meets%20Boy%20(2013)%2FGirl%20%20Meets%20Boy%20(2013).avi&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Girl Meets Boy (2013)/Girl Meets Boy (2013).avi May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FGod%20Help%20The%20Girl%20(2014)%2FGod%20Help%20The%20Girl%20(2014).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/God Help The Girl (2014)/God Help The Girl (2014).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FGotti%20(2018)%2FGotti%20(2018).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Gotti (2018)/Gotti (2018).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FGran%20Turismo%20(2023)%2FGran.Turismo.2023.1080p.WEBRip.x264.AAC5.1-%5BYTS.MX%5D.mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Gran Turismo (2023)/Gran.Turismo.2023.1080p.WEBRip.x264.AAC5.1-[YTS.MX].mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FGringo%20(2018)%2FGringo%20(2018).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Gringo (2018)/Gringo (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FHalloween%20(2018)%2FHalloween%20(2018).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Halloween (2018)/Halloween (2018).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FHeist%202015%2FHeist%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Heist 2015/Heist 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FHelios%20(2015)%2FHelios%20(2015).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Helios (2015)/Helios (2015).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FHidden%202015%2FHidden%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Hidden 2015/Hidden 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FHijack%20(2023)%2FHijack.2023.S01E01.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Hijack (2023)/Hijack.2023.S01E01.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FHijack%20(2023)%2FHijack.2023.S01E02.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Hijack (2023)/Hijack.2023.S01E02.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FHijack%20(2023)%2FHijack.2023.S01E03.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Hijack (2023)/Hijack.2023.S01E03.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FHollywood%20Road%20Trip%20(2015)%2FHollywood%20Road%20Trip%20(2015).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Hollywood Road Trip (2015)/Hollywood Road Trip (2015).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FHome%20(2015)%2FHome%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Home (2015)/Home (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FHome%20(2016)%2FHome%20(2016).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Home (2016)/Home (2016).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FHorns%20(2013)%2FHorns%20(2013).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Horns (2013)/Horns (2013).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FHot%20Pursuit%202015%2FHot%20Pursuit%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Hot Pursuit 2015/Hot Pursuit 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FI%20Feel%20Pretty%20(2018)%2FI%20Feel%20Pretty%20(2018).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/I Feel Pretty (2018)/I Feel Pretty (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FI%20Kill%20Giants%20(2018)%2FI%20Kill%20Giants%20(2018).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/I Kill Giants (2018)/I Kill Giants (2018).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FI%20Tonya%20(2017)%2FI%20Tonya%20(2017).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/I Tonya (2017)/I Tonya (2017).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FIT%20(2017)%2FIT%20(2017).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/IT (2017)/IT (2017).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FInfidus%20(2015)%2FInfidus%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Infidus (2015)/Infidus (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FInside%20Llewyn%20Davis%20(2013)%2FInside%20Llewyn%20Davis%20(2013).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Inside Llewyn Davis (2013)/Inside Llewyn Davis (2013).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FInside%20Llewyn%20Davis%20(2014)%2FInside%20Llewyn%20Davis%20(2014).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Inside Llewyn Davis (2014)/Inside Llewyn Davis (2014).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FInside%20Out%20(2015)%2FInside%20Out%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Inside Out (2015)/Inside Out (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FIntuition%202015%2FIntuition%202015.mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Intuition 2015/Intuition 2015.mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FJenny's%20Wedding%20(2015)%2FJenny's%20Wedding%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Jenny's Wedding (2015)/Jenny's Wedding (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FJohn%20Wick%20Chapter%202%20(2017)%2FJohn%20Wick%20Chapter%202%20(2017).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/John Wick Chapter 2 (2017)/John Wick Chapter 2 (2017).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FJohn%20Wick%20Chapter%204%20(2023)%2FJohn%20Wick%20Chapter%204%20(2023)%20Putlocker%20-%20Movies%20and%20Series.mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/John Wick Chapter 4 (2023)/John Wick Chapter 4 (2023) Putlocker - Movies and Series.mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FJumanji%20Welcome%20to%20the%20Jungle%20(2017)%2FJumanji%20Welcome%20to%20the%20Jungle%20(2017).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Jumanji Welcome to the Jungle (2017)/Jumanji Welcome to the Jungle (2017).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FJungle%20Cruise%20(2021)%2FJungle.Cruise.2021.1080p.WEB.H264-TIMECUT.mkv.mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Jungle Cruise (2021)/Jungle.Cruise.2021.1080p.WEB.H264-TIMECUT.mkv.mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FJurasic%20World%20(2018)%2FJurasic%20World%20(2018).mkv&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Jurasic World (2018)/Jurasic World (2018).mkv May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FJurassic%20World%20(2015)%2FJurassic%20World%20(2015).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Jurassic World (2015)/Jurassic World (2015).mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2FJurassic%20World%20Dominion%20(2022)%2FJurassic%20World%20Dominion%20(2022)%20Putlocker%20-%20Movies%20and%20Series.mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/Jurassic World Dominion (2022)/Jurassic World Dominion (2022) Putlocker - Movies and Series.mp4 May 01 18:42:06 volumioa volumio[8052]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FNAS%2FMedia%2FMovies%2Fimmortals%20(2011)%2Fimmortals%20(2011).mp4&metadata=false May 01 18:42:06 volumioa volumio[8052]: info: URI /mnt/NAS/Media/Movies/immortals (2011)/immortals (2011).mp4 May 01 18:42:06 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushQueue May 01 18:42:06 volumioa volumio[8052]: info: CorePlayQueue::saveQueue May 01 18:42:06 volumioa volumio[8052]: info: CoreStateMachine::updateTrackBlock May 01 18:42:06 volumioa volumio[8052]: info: CorePlayQueue::getTrackBlock May 01 18:42:06 volumioa volumio[8052]: info: CoreCommandRouter::volumioPlay May 01 18:42:06 volumioa volumio[8052]: info: CoreStateMachine::play index 0 May 01 18:42:06 volumioa volumio[8052]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 18:42:06 volumioa volumio[8052]: info: CoreStateMachine::stop May 01 18:42:06 volumioa volumio[8052]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 18:42:06 volumioa volumio[8052]: info: CoreStateMachine::play index undefined May 01 18:42:06 volumioa volumio[8052]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 18:42:06 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:06 volumioa volumio[8052]: info: CoreStateMachine::startPlaybackTimer May 01 18:42:06 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:06 volumioa volumio[8052]: verbose: ControllerMpd::clearAddPlayTracks NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4 May 01 18:42:06 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand stop May 01 18:42:06 volumioa volumio[8052]: info: sendMpdCommand stop took 403 milliseconds May 01 18:42:06 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand clear May 01 18:42:06 volumioa volumio[8052]: info: May 01 18:42:06 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:06 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:06 volumioa volumio[8052]: info: sendMpdCommand clear took 12 milliseconds May 01 18:42:06 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand add "NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4" May 01 18:42:06 volumioa volumio[8052]: info: May 01 18:42:06 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:06 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:06 volumioa volumio[8052]: info: May 01 18:42:06 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:06 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:06 volumioa volumio[8052]: info: May 01 18:42:06 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:06 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:06 volumioa volumio[8052]: error: updateQueue error: null May 01 18:42:06 volumioa volumio[8052]: info: May 01 18:42:06 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:06 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:06 volumioa volumio[8052]: info: ------------------------------ 12ms May 01 18:42:06 volumioa volumio[8052]: info: sendMpdCommand add "NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4" took 10 milliseconds May 01 18:42:06 volumioa volumio[8052]: info: ------------------------------ 9ms May 01 18:42:06 volumioa volumio[8052]: info: ------------------------------ 9ms May 01 18:42:06 volumioa volumio[8052]: info: ------------------------------ 8ms May 01 18:42:06 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand play May 01 18:42:06 volumioa volumio[8052]: info: May 01 18:42:06 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:06 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:06 volumioa volumio[8052]: info: May 01 18:42:06 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:06 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:06 volumioa volumio[8052]: info: May 01 18:42:06 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:06 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:06 volumioa volumio[8052]: info: ------------------------------ 20ms May 01 18:42:06 volumioa volumio[8052]: info: sendMpdCommand play took 18 milliseconds May 01 18:42:06 volumioa volumio[8052]: info: ------------------------------ 17ms May 01 18:42:06 volumioa volumio[8052]: info: ------------------------------ 16ms May 01 18:42:06 volumioa volumio[8052]: info: ------------------------------ 15ms May 01 18:42:06 volumioa volumio[8052]: info: Setting Geolocation for MyVolumio to us3 May 01 18:42:06 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:06 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:06 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:07 volumioa volumio[8052]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} May 01 18:42:07 volumioa volumio[8052]: info: AutoStart - Plugin is starting May 01 18:42:07 volumioa volumio[8052]: info: CoreCommandRouter::volumioGetQueue May 01 18:42:07 volumioa volumio[8052]: info: CoreStateMachine::getQueue May 01 18:42:07 volumioa volumio[8052]: info: CorePlayQueue::getQueue May 01 18:42:07 volumioa volumio[8052]: info: AutoStart - start playing May 01 18:42:07 volumioa volumio[8052]: info: AutoStart - start playing with no specific position May 01 18:42:07 volumioa volumio[8052]: info: CoreCommandRouter::volumioPlay May 01 18:42:07 volumioa volumio[8052]: info: CoreStateMachine::play index 0 May 01 18:42:07 volumioa volumio[8052]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 18:42:07 volumioa volumio[8052]: info: CoreStateMachine::stop May 01 18:42:07 volumioa volumio[8052]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 18:42:07 volumioa volumio[8052]: info: CoreStateMachine::play index undefined May 01 18:42:07 volumioa volumio[8052]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 18:42:07 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:07 volumioa volumio[8052]: info: CoreStateMachine::startPlaybackTimer May 01 18:42:07 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:07 volumioa volumio[8052]: verbose: ControllerMpd::clearAddPlayTracks NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4 May 01 18:42:07 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand stop May 01 18:42:07 volumioa volumio[8052]: info: Updating MyVolumio device info May 01 18:42:07 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:07 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:07 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:08 volumioa volumio[8052]: info: May 01 18:42:08 volumioa volumio[8052]: ---------------------------- MPD announces state update: player May 01 18:42:08 volumioa volumio[8052]: info: sendMpdCommand stop took 303 milliseconds May 01 18:42:08 volumioa volumio[8052]: info: ControllerMpd::getState May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand status May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand clear May 01 18:42:08 volumioa volumio[8052]: info: May 01 18:42:08 volumioa volumio[8052]: ---------------------------- MPD announces state update: player May 01 18:42:08 volumioa volumio[8052]: info: ControllerMpd::getState May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand status May 01 18:42:08 volumioa volumio[8052]: info: May 01 18:42:08 volumioa volumio[8052]: ---------------------------- MPD announces state update: player May 01 18:42:08 volumioa volumio[8052]: info: ControllerMpd::getState May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand status May 01 18:42:08 volumioa volumio[8052]: info: May 01 18:42:08 volumioa volumio[8052]: ---------------------------- MPD announces state update: player May 01 18:42:08 volumioa volumio[8052]: info: ControllerMpd::getState May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand status May 01 18:42:08 volumioa volumio[8052]: info: sendMpdCommand status took 12 milliseconds May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::parseState May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 18:42:08 volumioa volumio[8052]: info: May 01 18:42:08 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:08 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:08 volumioa volumio[8052]: info: sendMpdCommand clear took 14 milliseconds May 01 18:42:08 volumioa volumio[8052]: info: sendMpdCommand status took 8 milliseconds May 01 18:42:08 volumioa volumio[8052]: info: sendMpdCommand status took 7 milliseconds May 01 18:42:08 volumioa volumio[8052]: info: sendMpdCommand status took 6 milliseconds May 01 18:42:08 volumioa volumio[8052]: info: sendMpdCommand playlistinfo took 2 milliseconds May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand add "NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4" May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::parseState May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::parseState May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::parseState May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::parseTrackInfo May 01 18:42:08 volumioa volumio[8052]: info: ControllerMpd::pushState May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::servicePushState May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:08 volumioa volumio[8052]: 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} May 01 18:42:08 volumioa volumio[8052]: verbose: CURRENT POSITION 0 May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::syncState stateService stop May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::syncState currentStatus stop May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:08 volumioa volumio[8052]: info: No code May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:08 volumioa volumio[8052]: info: ControllerMpd::pushState May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::servicePushState May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:08 volumioa volumio[8052]: 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} May 01 18:42:08 volumioa volumio[8052]: verbose: CURRENT POSITION 0 May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::syncState stateService stop May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::syncState currentStatus stop May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:08 volumioa volumio[8052]: info: No code May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:08 volumioa volumio[8052]: info: ControllerMpd::pushState May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::servicePushState May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:08 volumioa volumio[8052]: 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} May 01 18:42:08 volumioa volumio[8052]: verbose: CURRENT POSITION 0 May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::syncState stateService stop May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::syncState currentStatus stop May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:08 volumioa volumio[8052]: info: No code May 01 18:42:08 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:08 volumioa volumio[8052]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 18:42:08 volumioa volumio[8052]: info: ------------------------------ 148ms May 01 18:42:08 volumioa volumio[8052]: info: ------------------------------ 144ms May 01 18:42:08 volumioa volumio[8052]: info: ------------------------------ 144ms May 01 18:42:08 volumioa volumio[8052]: info: ------------------------------ 155ms May 01 18:42:08 volumioa volumio[8052]: info: May 01 18:42:08 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:08 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:08 volumioa volumio[8052]: info: May 01 18:42:08 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:08 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:08 volumioa volumio[8052]: info: May 01 18:42:08 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:08 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:08 volumioa volumio[8052]: error: updateQueue error: null May 01 18:42:08 volumioa volumio[8052]: info: May 01 18:42:08 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:08 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:08 volumioa volumio[8052]: info: ------------------------------ 146ms May 01 18:42:08 volumioa volumio[8052]: info: sendMpdCommand add "NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4" took 144 milliseconds May 01 18:42:08 volumioa volumio[8052]: info: ------------------------------ 7ms May 01 18:42:08 volumioa volumio[8052]: info: ------------------------------ 6ms May 01 18:42:08 volumioa volumio[8052]: info: ------------------------------ 5ms May 01 18:42:08 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand play May 01 18:42:08 volumioa volumio[8052]: info: May 01 18:42:08 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:08 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:08 volumioa volumio[8052]: info: May 01 18:42:08 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:08 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:08 volumioa volumio[8052]: info: May 01 18:42:08 volumioa volumio[8052]: ---------------------------- MPD announces system playlist update May 01 18:42:08 volumioa volumio[8052]: info: Ignoring MPD Status Update May 01 18:42:08 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:08 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:08 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:08 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:08 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:08 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:08 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:08 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:08 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:08 volumioa volumio[8052]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} May 01 18:42:08 volumioa volumio[8052]: info: ------------------------------ 84ms May 01 18:42:08 volumioa volumio[8052]: info: sendMpdCommand play took 82 milliseconds May 01 18:42:08 volumioa volumio[8052]: info: ------------------------------ 66ms May 01 18:42:08 volumioa volumio[8052]: info: ------------------------------ 66ms May 01 18:42:08 volumioa volumio[8052]: info: ------------------------------ 65ms May 01 18:42:08 volumioa volumio[8052]: info: CoreCommandRouter::volumioGetState May 01 18:42:08 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: May 01 18:42:09 volumioa volumio[8052]: ---------------------------- MPD announces state update: player May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::getState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand status May 01 18:42:09 volumioa volumio[8052]: info: May 01 18:42:09 volumioa volumio[8052]: ---------------------------- MPD announces state update: player May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::getState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand status May 01 18:42:09 volumioa volumio[8052]: info: May 01 18:42:09 volumioa volumio[8052]: ---------------------------- MPD announces state update: player May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::getState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand status May 01 18:42:09 volumioa volumio[8052]: info: May 01 18:42:09 volumioa volumio[8052]: ---------------------------- MPD announces state update: player May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::getState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand status May 01 18:42:09 volumioa volumio[8052]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 May 01 18:42:09 volumioa volumio[8052]: info: FusionDsp - ---- read samplerate from file: 48000 May 01 18:42:09 volumioa volumio[8052]: info: camilladsp stopping service pid 8377... May 01 18:42:09 volumioa volumio[8052]: info: camilladsp service terminated, instance 1 May 01 18:42:09 volumioa volumio[8052]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 01 18:42:09 volumioa volumio[8052]: info: camilladsp service started and running in background, instance 1 May 01 18:42:09 volumioa volumio[8052]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 May 01 18:42:09 volumioa volumio[8052]: info: FusionDsp - ---- read samplerate from file: 48000 May 01 18:42:09 volumioa volumio[8052]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 01 18:42:09 volumioa volumio[8052]: info: May 01 18:42:09 volumioa volumio[8052]: ---------------------------- MPD announces state update: player May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand status took 86 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::getState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand status May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand status took 85 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand status took 83 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand status took 81 milliseconds May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 18:42:09 volumioa volumio[8052]: info: May 01 18:42:09 volumioa volumio[8052]: ---------------------------- MPD announces state update: player May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::getState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand status May 01 18:42:09 volumioa volumio[8052]: info: May 01 18:42:09 volumioa volumio[8052]: ---------------------------- MPD announces state update: player May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::getState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand status May 01 18:42:09 volumioa volumio[8052]: info: May 01 18:42:09 volumioa volumio[8052]: ---------------------------- MPD announces state update: player May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::getState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand status May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand status took 20 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand playlistinfo took 19 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand playlistinfo took 18 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand playlistinfo took 17 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand playlistinfo took 17 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand status took 15 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand status took 13 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand status took 12 milliseconds May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseTrackInfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseTrackInfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseTrackInfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseTrackInfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseState May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::pushState May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::servicePushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":7790,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"130 Kbps","isStreaming":false,"title":"EVO","artist":null,"album":null,"uri":"NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4","trackType":"mp4"} May 01 18:42:09 volumioa volumio[8052]: verbose: CURRENT POSITION 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState stateService play May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState currentStatus stop May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::pushState May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::servicePushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":210,"duration":7790,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"130 Kbps","isStreaming":false,"title":"EVO","artist":null,"album":null,"uri":"NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4","trackType":"mp4"} May 01 18:42:09 volumioa volumio[8052]: verbose: CURRENT POSITION 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState stateService play May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState currentStatus play May 01 18:42:09 volumioa volumio[8052]: info: Received an update from plugin. extracting info from payload May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::pushState May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::servicePushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":483,"duration":7790,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"130 Kbps","isStreaming":false,"title":"EVO","artist":null,"album":null,"uri":"NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4","trackType":"mp4"} May 01 18:42:09 volumioa volumio[8052]: verbose: CURRENT POSITION 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState stateService play May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState currentStatus play May 01 18:42:09 volumioa volumio[8052]: info: Received an update from plugin. extracting info from payload May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::pushState May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::servicePushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":483,"duration":7790,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"130 Kbps","isStreaming":false,"title":"EVO","artist":null,"album":null,"uri":"NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4","trackType":"mp4"} May 01 18:42:09 volumioa volumio[8052]: verbose: CURRENT POSITION 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState stateService play May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState currentStatus play May 01 18:42:09 volumioa volumio[8052]: info: Received an update from plugin. extracting info from payload May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: ------------------------------ 134ms May 01 18:42:09 volumioa volumio[8052]: info: ------------------------------ 187ms May 01 18:42:09 volumioa volumio[8052]: info: ------------------------------ 185ms May 01 18:42:09 volumioa volumio[8052]: info: ------------------------------ 184ms May 01 18:42:09 volumioa volumio[8052]: error: FusionDsp - WebSocket error: [object Object] May 01 18:42:09 volumioa volumio[8052]: info: camilladsp spawned new process with pid 8453, instance 1, run: true May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand playlistinfo took 116 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand playlistinfo took 115 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand playlistinfo took 115 milliseconds May 01 18:42:09 volumioa volumio[8052]: info: sendMpdCommand playlistinfo took 116 milliseconds May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseTrackInfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseTrackInfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseTrackInfo May 01 18:42:09 volumioa volumio[8052]: verbose: ControllerMpd::parseTrackInfo May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::pushState May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::servicePushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1113,"duration":7790,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"130 Kbps","isStreaming":false,"title":"EVO","artist":null,"album":null,"uri":"NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4","trackType":"mp4"} May 01 18:42:09 volumioa volumio[8052]: verbose: CURRENT POSITION 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState stateService play May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState currentStatus play May 01 18:42:09 volumioa volumio[8052]: info: Received an update from plugin. extracting info from payload May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::pushState May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::servicePushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1113,"duration":7790,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"130 Kbps","isStreaming":false,"title":"EVO","artist":null,"album":null,"uri":"NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4","trackType":"mp4"} May 01 18:42:09 volumioa volumio[8052]: verbose: CURRENT POSITION 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState stateService play May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState currentStatus play May 01 18:42:09 volumioa volumio[8052]: info: Received an update from plugin. extracting info from payload May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::pushState May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::servicePushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1113,"duration":7790,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"130 Kbps","isStreaming":false,"title":"EVO","artist":null,"album":null,"uri":"NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4","trackType":"mp4"} May 01 18:42:09 volumioa volumio[8052]: verbose: CURRENT POSITION 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState stateService play May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState currentStatus play May 01 18:42:09 volumioa volumio[8052]: info: Received an update from plugin. extracting info from payload May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: ControllerMpd::pushState May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::servicePushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1113,"duration":7790,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"130 Kbps","isStreaming":false,"title":"EVO","artist":null,"album":null,"uri":"NAS/Media/Movies/12 Strong (2018)/12 Strong (2018).mp4","trackType":"mp4"} May 01 18:42:09 volumioa volumio[8052]: verbose: CURRENT POSITION 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState stateService play May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::syncState currentStatus play May 01 18:42:09 volumioa volumio[8052]: info: Received an update from plugin. extracting info from payload May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:09 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:09 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:09 volumioa volumio[8052]: info: ------------------------------ 276ms May 01 18:42:09 volumioa volumio[8052]: info: ------------------------------ 270ms May 01 18:42:09 volumioa volumio[8052]: info: ------------------------------ 270ms May 01 18:42:09 volumioa volumio[8052]: info: ------------------------------ 269ms May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:09 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:13 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 01 18:42:13 volumioa volumio[8052]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13 May 01 18:42:13 volumioa volumio[8052]: info: CoreCommandRouter::volumioGetState May 01 18:42:13 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:15 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 01 18:42:15 volumioa volumio[8052]: info: Preload queue cleared May 01 18:42:17 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 01 18:42:17 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:17 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 01 18:42:17 volumioa volumio-remote-updater[19683]: No test mode May 01 18:42:17 volumioa volumio-remote-updater[19683]: No alpha test mode May 01 18:42:17 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 01 18:42:18 volumioa volumio[8052]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 01 18:42:18 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 01 18:42:18 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:42:18 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:42:18 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 01 18:42:18 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 01 18:42:18 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 01 18:42:18 volumioa volumio[8052]: info: CoreCommandRouter::volumioGetBrowseSources May 01 18:42:18 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 01 18:42:19 volumioa volumio[8052]: error: MyVolumio Plugin failed to authenticate in a timely fashion May 01 18:42:19 volumioa volumio[8052]: info: Completed starting MyVolumio Plugin May 01 18:42:19 volumioa volumio[8052]: info: BOOT COMPLETED May 01 18:42:19 volumioa volumio[8052]: [Metrics] CommandRouter: 70s 691.13ms May 01 18:42:19 volumioa volumio[8052]: info: CoreCommandRouter::volumiosetStartupVolume May 01 18:42:19 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:42:19 volumioa volumio[8052]: info: VolumeController:: Setting startup Volume 20 May 01 18:42:19 volumioa volumio[8052]: info: VolumeController::SetAlsaVolume20 May 01 18:42:19 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:19 volumioa volumio[8052]: info: CoreCommandRouter::Close All Modals sent May 01 18:42:19 volumioa volumio[8052]: info: CoreCommandRouter::Close All Modals sent May 01 18:42:19 volumioa volumio[8052]: info: CoreCommandRouter::volumioGetState May 01 18:42:19 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:19 volumioa volumio[8052]: info: CoreStateMachine::pushState May 01 18:42:19 volumioa volumio[8052]: info: CorePlayQueue::getTrack 0 May 01 18:42:19 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:42:19 volumioa volumio[8052]: info: CoreCommandRouter::volumioPushState May 01 18:42:19 volumioa volumio[8052]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 May 01 18:42:19 volumioa volumio[8052]: SPOTIFY: SPOTIFY VOLUME 20 May 01 18:42:19 volumioa volumio[8052]: SPOTIFY: VOLUMIO VOLUME 20 May 01 18:42:19 volumioa volumio[8052]: SPOTIFY: DELTA VOLUME ENOUGH: false May 01 18:42:19 volumioa volumio[8052]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 01 18:42:19 volumioa volumio[8052]: info: FusionDsp - ---- read samplerate from file: 44100 May 01 18:42:19 volumioa volumio[8052]: info: camilladsp stopping service pid 8453... May 01 18:42:19 volumioa volumio[8052]: info: camilladsp service terminated, instance 1 May 01 18:42:19 volumioa volumio[8052]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 01 18:42:19 volumioa volumio[8052]: info: camilladsp service started and running in background, instance 1 May 01 18:42:19 volumioa volumio[8052]: info: camilladsp spawned new process with pid 8469, instance 1, run: true May 01 18:42:19 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 01 18:42:19 volumioa volumio[8052]: info: Preload queue cleared May 01 18:42:20 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 01 18:42:20 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 01 18:42:20 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 01 18:42:22 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 01 18:42:22 volumioa volumio[8052]: info: Preload queue cleared May 01 18:42:26 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 01 18:42:26 volumioa volumio[8052]: info: Preload queue cleared May 01 18:42:31 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 01 18:42:31 volumioa volumio[8052]: error: Error browsingac85fabf-dbf8-4d36-a3d2-1ff357402804:Error: Did not get expected response from server:{"Envelope":{"$":{"s:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/","xmlns:s":"http://schemas.xmlsoap.org/soap/envelope/"},"Body":[{"Fault":[{"faultcode":[{"_":"s:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"501"}],"errorDescription":[{"_":"Action failed"}]}]}]}]}]}} May 01 18:42:31 volumioa volumio[8052]: error: Failed to execute browseSource: May 01 18:42:36 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 01 18:42:36 volumioa volumio[8052]: info: Preload queue cleared May 01 18:42:39 volumioa volumio[8052]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 01 18:42:39 volumioa volumio[8052]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 18:42:39 volumioa volumio[8052]: TypeError: Cannot read property 'length' of undefined May 01 18:42:39 volumioa volumio[8052]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 01 18:42:39 volumioa volumio[8052]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 01 18:42:39 volumioa volumio[8052]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 01 18:42:39 volumioa volumio[8052]: at Parser.emit (events.js:315:20) May 01 18:42:39 volumioa volumio[8052]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 01 18:42:39 volumioa volumio[8052]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 01 18:42:39 volumioa volumio[8052]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 01 18:42:39 volumioa volumio[8052]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 01 18:42:39 volumioa volumio[8052]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 01 18:42:39 volumioa volumio[8052]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 01 18:42:39 volumioa volumio[8052]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 01 18:42:39 volumioa volumio[8052]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 01 18:42:39 volumioa volumio[8052]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 01 18:42:39 volumioa volumio[8052]: at IncomingMessage.emit (events.js:327:22) May 01 18:42:39 volumioa volumio[8052]: at endReadableNT (internal/streams/readable.js:1327:12) May 01 18:42:39 volumioa volumio[8052]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 01 18:42:39 volumioa volumio[8052]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 18:42:40 volumioa sudo[8532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 18:41 May 01 18:42:40 volumioa sudo[8532]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:40 volumioa sudo[8532]: pam_unix(sudo:session): session closed for user root May 01 18:42:40 volumioa volumio-remote-updater[19683]: [2024-05-01 18:42:40] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 01 18:42:40 volumioa volumio-remote-updater[19683]: [2024-05-01 18:42:40] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 01 18:42:40 volumioa go-librespot[8347]: time="2024-05-01T18:42:40-04:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" May 01 18:42:40 volumioa systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 01 18:42:40 volumioa systemd[1]: volumio.service: Failed with result 'exit-code'. May 01 18:42:40 volumioa systemd[1]: Started dynamicswap service. May 01 18:42:40 volumioa systemd[1]: dynamicswap.service: Succeeded. May 01 18:42:40 volumioa systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 01 18:42:40 volumioa systemd[1]: volumio.service: Scheduled restart job, restart counter is at 5. May 01 18:42:40 volumioa systemd[1]: Stopped Volumio Backend Module. May 01 18:42:40 volumioa systemd[1]: Started Volumio Backend Module. May 01 18:42:40 volumioa systemd[1]: Started dynamicswap service. May 01 18:42:40 volumioa systemd[1]: dynamicswap.service: Succeeded. May 01 18:42:41 volumioa volumio[8543]: info: ------------------------------------------- May 01 18:42:41 volumioa volumio[8543]: info: ----- Volumio3 ---- May 01 18:42:41 volumioa volumio[8543]: info: ------------------------------------------- May 01 18:42:41 volumioa volumio[8543]: info: ----- System startup ---- May 01 18:42:41 volumioa volumio[8543]: info: ------------------------------------------- May 01 18:42:42 volumioa volumio[8543]: info: MYVOLUMIO Environment detected May 01 18:42:42 volumioa volumio[8543]: info: Plugin folders cleanup May 01 18:42:42 volumioa volumio[8543]: info: Scanning into folder /volumio/app/plugins/ May 01 18:42:42 volumioa volumio[8543]: info: Scanning category audio_interface May 01 18:42:42 volumioa volumio[8543]: info: Scanning category miscellanea May 01 18:42:42 volumioa volumio[8543]: info: Scanning category music_service May 01 18:42:42 volumioa volumio[8543]: info: Scanning category plugins.json May 01 18:42:42 volumioa volumio[8543]: info: Scanning category system_controller May 01 18:42:42 volumioa volumio[8543]: info: Scanning category user_interface May 01 18:42:42 volumioa volumio[8543]: info: Scanning into folder /data/plugins/ May 01 18:42:42 volumioa volumio[8543]: info: Scanning category audio_interface May 01 18:42:42 volumioa volumio[8543]: info: Scanning category music_service May 01 18:42:42 volumioa volumio[8543]: info: Scanning category system_controller May 01 18:42:42 volumioa volumio[8543]: info: Scanning category system_hardware May 01 18:42:42 volumioa volumio[8543]: info: Scanning category user_interface May 01 18:42:42 volumioa volumio[8543]: info: Plugin folders cleanup completed May 01 18:42:42 volumioa volumio[8543]: info: ------------------------------------------- May 01 18:42:42 volumioa volumio[8543]: info: ----- Core plugins startup ---- May 01 18:42:42 volumioa volumio[8543]: info: ------------------------------------------- May 01 18:42:42 volumioa volumio[8543]: info: Loading plugins from folder /volumio/app/plugins/ May 01 18:42:42 volumioa volumio[8543]: info: Adding plugin upnp to MyMusic Plugins May 01 18:42:42 volumioa volumio[8543]: info: Adding plugin airplay_emulation to MyMusic Plugins May 01 18:42:42 volumioa volumio[8543]: info: Adding plugin upnp_browser to MyMusic Plugins May 01 18:42:42 volumioa volumio[8543]: info: Loading plugins from folder /data/plugins/ May 01 18:42:42 volumioa volumio[8543]: info: Loading plugin "system"... May 01 18:42:42 volumioa volumio[8543]: info: Loading plugin "appearance"... May 01 18:42:42 volumioa volumio[8543]: info: Loading plugin "network"... May 01 18:42:42 volumioa volumio[8543]: info: Refreshing Cached IP Addresses May 01 18:42:42 volumioa sudo[8570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 18:42:42 volumioa volumio[8543]: info: Loading plugin "services"... May 01 18:42:42 volumioa sudo[8570]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:42 volumioa volumio[8543]: info: Loading plugin "alsa_controller"... May 01 18:42:42 volumioa sudo[8570]: pam_unix(sudo:session): session closed for user root May 01 18:42:42 volumioa sudo[8572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 18:42:42 volumioa sudo[8572]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:42 volumioa sudo[8572]: pam_unix(sudo:session): session closed for user root May 01 18:42:42 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 01 18:42:42 volumioa volumio[8543]: info: Loading plugin "wizard"... May 01 18:42:42 volumioa volumio[8543]: info: Loading plugin "networkfs"... May 01 18:42:42 volumioa volumio[8543]: info: Cannot mount NAS Nas at system boot, trial number 1 ,retrying in 5 seconds May 01 18:42:42 volumioa volumio[8543]: info: Cannot mount NAS Media at system boot, trial number 1 ,retrying in 5 seconds May 01 18:42:42 volumioa volumio[8543]: info: Starting Udev Watcher for removable devices May 01 18:42:42 volumioa volumio[8543]: info: Ignoring mount for partition: boot May 01 18:42:42 volumioa volumio[8543]: info: Ignoring mount for partition: volumio May 01 18:42:42 volumioa volumio[8543]: info: Ignoring mount for partition: volumio_data May 01 18:42:42 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 18:42:42 volumioa volumio[8543]: info: Loading plugin "volumio_command_line_client"... May 01 18:42:42 volumioa volumio[8543]: info: Loading plugin "upnp"... May 01 18:42:42 volumioa volumio[8543]: info: [1714603362962] Starting Upmpd Daemon May 01 18:42:42 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 18:42:42 volumioa volumio[8543]: info: Loading plugin "my_music"... May 01 18:42:42 volumioa volumio[8543]: info: Loading plugin "mpd"... May 01 18:42:43 volumioa volumio[8543]: info: Loading plugin "upnp_browser"... May 01 18:42:43 volumioa volumio[8543]: info: Loading plugin "alarm-clock"... May 01 18:42:43 volumioa volumio[8543]: info: Loading plugin "airplay_emulation"... May 01 18:42:43 volumioa volumio[8543]: info: Starting Shairport Sync May 01 18:42:43 volumioa volumio[8543]: info: Loading plugin "last_100"... May 01 18:42:43 volumioa volumio[8543]: info: Loading plugin "webradio"... May 01 18:42:43 volumioa volumio[8543]: info: Loading plugin "i2s_dacs"... May 01 18:42:43 volumioa volumio[8543]: info: I2S DAC not set, start Auto-detection May 01 18:42:43 volumioa volumio[8543]: info: Loading plugin "volumiodiscovery"... May 01 18:42:43 volumioa volumio[8543]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 01 18:42:43 volumioa node[8543]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 01 18:42:43 volumioa node[8543]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 18:42:43 volumioa volumio[8543]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 18:42:43 volumioa volumio[8543]: *** WARNING *** For more information see May 01 18:42:43 volumioa volumio[8543]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 01 18:42:43 volumioa volumio[8543]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 18:42:43 volumioa volumio[8543]: *** WARNING *** For more information see May 01 18:42:43 volumioa node[8543]: *** WARNING *** For more information see May 01 18:42:43 volumioa node[8543]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 01 18:42:43 volumioa node[8543]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 18:42:43 volumioa node[8543]: *** WARNING *** For more information see May 01 18:42:43 volumioa volumio[8543]: info: Applying required configuration parameters for plugin volumiodiscovery May 01 18:42:43 volumioa volumio[8543]: info: Discovery: Started advertising with name: VolumioA May 01 18:42:43 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 18:42:43 volumioa volumio[8543]: info: Loading plugin "spop"... May 01 18:42:44 volumioa volumio[8543]: info: Loading plugin "youtube2"... May 01 18:42:44 volumioa volumio[8543]: info: Loading plugin "ytcr"... May 01 18:42:45 volumioa volumio-remote-updater[19683]: [2024-05-01 18:42:45] [connect] Successful connection May 01 18:42:46 volumioa volumio[8543]: info: Loading plugin "ytmusic"... May 01 18:42:46 volumioa volumio[8543]: info: Loading plugin "autostart"... May 01 18:42:46 volumioa volumio[8543]: info: Applying required configuration parameters for plugin autostart May 01 18:42:46 volumioa volumio[8543]: info: AutoStart - onVolumioStart - read config.json May 01 18:42:46 volumioa volumio[8543]: info: Loading plugin "now_playing"... May 01 18:42:47 volumioa volumio[8543]: info: Loading plugin "outputs"... May 01 18:42:47 volumioa volumio[8543]: info: Loading plugin "albumart"... May 01 18:42:47 volumioa volumio[8543]: info: Plugin example_plugin is not enabled May 01 18:42:47 volumioa volumio[8543]: info: Loading plugin "inputs"... May 01 18:42:47 volumioa volumio[8543]: info: Loading plugin "updater_comm"... May 01 18:42:47 volumioa volumio[8543]: info: Plugin mpdemulation is not enabled May 01 18:42:47 volumioa volumio[8543]: info: Loading plugin "rest_api"... May 01 18:42:47 volumioa volumio[8543]: info: Loading plugin "websocket"... May 01 18:42:47 volumioa volumio[8543]: info: Loading plugin "fusiondsp"... May 01 18:42:47 volumioa volumio[8543]: Forking 3 albumart workers May 01 18:42:47 volumioa volumio[8543]: info: Applying required configuration parameters for plugin fusiondsp May 01 18:42:47 volumioa volumio[8543]: info: Loading plugin "volusonic"... May 01 18:42:48 volumioa volumio[8543]: Starting albumart workers May 01 18:42:48 volumioa volumio[8543]: Starting albumart workers May 01 18:42:48 volumioa volumio[8543]: Starting albumart workers May 01 18:42:48 volumioa volumio[8543]: info: Applying required configuration parameters for plugin volusonic May 01 18:42:48 volumioa volumio[8543]: info: Loading plugin "backup_restore"... May 01 18:42:48 volumioa volumio[8543]: info: Applying required configuration parameters for plugin backup_restore May 01 18:42:48 volumioa volumio[8543]: info: Plugin music_services_shield is not enabled May 01 18:42:48 volumioa volumio[8543]: info: Loading plugin "Systeminfo"... May 01 18:42:48 volumioa volumio[8543]: info: Loading plugin "randomizer"... May 01 18:42:49 volumioa volumio[8543]: info: Applying required configuration parameters for plugin randomizer May 01 18:42:49 volumioa volumio[8543]: info: Loading plugin "touch_display"... May 01 18:42:49 volumioa volumio[8543]: info: Applying required configuration parameters for plugin touch_display May 01 18:42:49 volumioa volumio[8543]: info: Loading i18n strings for locale en May 01 18:42:49 volumioa volumio[8543]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored. May 01 18:42:49 volumioa volumio[8543]: Updating browse sources language May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::initPlayerControls May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 18:42:49 volumioa volumio[8543]: Express server listening on port 3000 May 01 18:42:49 volumioa volumio[8543]: [Metrics] WebUI: 8s 62.06ms May 01 18:42:49 volumioa volumio[8543]: info: CoreStateMachine::resetVolumioState May 01 18:42:49 volumioa volumio[8543]: info: CoreStateMachine::getcurrentVolume May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::volumioRetrievevolume May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:42:49 volumioa volumio[8543]: info: Cannot mount NAS Nas at system boot, trial number 2 ,retrying in 5 seconds May 01 18:42:49 volumioa volumio[8543]: info: Cannot mount NAS Media at system boot, trial number 2 ,retrying in 5 seconds May 01 18:42:49 volumioa volumio[8543]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 1 May 01 18:42:49 volumioa volumio[8543]: verbose: New Socket.io Connection to 10.0.0.139 from 10.0.0.26 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 2 May 01 18:42:49 volumioa volumio[8543]: verbose: New Socket.io Connection to 10.0.0.139 from 10.0.0.26 UA: unknown Total Clients: 3 May 01 18:42:49 volumioa volumio[8543]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 4 May 01 18:42:49 volumioa volumio-remote-updater[19683]: [2024-05-01 18:42:49] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714603365 101 May 01 18:42:49 volumioa volumio[8543]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 5 May 01 18:42:49 volumioa volumio[8543]: info: CoreStateMachine::pushState May 01 18:42:49 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::volumioPushState May 01 18:42:49 volumioa volumio[8543]: info: CoreStateMachine::updateTrackBlock May 01 18:42:49 volumioa volumio[8543]: info: CorePlayQueue::getTrackBlock May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::volumioRetrievevolume May 01 18:42:49 volumioa volumio[8543]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 May 01 18:42:49 volumioa volumio[8543]: info: Reloading queue from file May 01 18:42:49 volumioa volumio[8543]: info: CoreStateMachine::setRepeat true single undefined May 01 18:42:49 volumioa volumio[8543]: info: CoreStateMachine::pushState May 01 18:42:49 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::volumioPushState May 01 18:42:49 volumioa volumio[8543]: info: CoreStateMachine::setRandom true May 01 18:42:49 volumioa volumio[8543]: info: CoreStateMachine::pushState May 01 18:42:49 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::volumioPushState May 01 18:42:49 volumioa volumio[8543]: info: Setting Device type: Raspberry PI May 01 18:42:49 volumioa volumio[8543]: info: CoreStateMachine::pushState May 01 18:42:49 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::volumioPushState May 01 18:42:49 volumioa volumio[8543]: info: Discovery: adding 39de326e-0c8d-49e6-ad8a-8e06195d9e03 May 01 18:42:49 volumioa volumio[8543]: info: Discovery: Found device VolumioA May 01 18:42:49 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetState May 01 18:42:49 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:50 volumioa volumio[8543]: verbose: New Socket.io Connection to 10.0.0.139 from 10.0.0.26 UA: unknown Total Clients: 6 May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetState May 01 18:42:50 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:50 volumioa volumio[8543]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 7 May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetVisibleSources May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetState May 01 18:42:50 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 18:42:50 volumioa volumio[8543]: info: Received Get System Info May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 18:42:50 volumioa volumio[8543]: info: Discovery: Getting this device information May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetState May 01 18:42:50 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetState May 01 18:42:50 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:50 volumioa volumio[8543]: info: Listing playlists May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 18:42:50 volumioa volumio[8543]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 18:42:52 volumioa sudo[8653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 18:42:52 volumioa sudo[8653]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:52 volumioa sudo[8653]: pam_unix(sudo:session): session closed for user root May 01 18:42:52 volumioa sudo[8656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 18:42:52 volumioa sudo[8656]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:52 volumioa sudo[8656]: pam_unix(sudo:session): session closed for user root May 01 18:42:52 volumioa volumio[8543]: verbose: New Socket.io Connection to 10.0.0.139 from 10.0.0.26 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 8 May 01 18:42:52 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 01 18:42:52 volumioa sudo[8659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 18:42:52 volumioa sudo[8659]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:52 volumioa sudo[8659]: pam_unix(sudo:session): session closed for user root May 01 18:42:52 volumioa sudo[8662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 18:42:52 volumioa sudo[8662]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:52 volumioa sudo[8662]: pam_unix(sudo:session): session closed for user root May 01 18:42:52 volumioa volumio[8543]: verbose: New Socket.io Connection to 10.0.0.139 from 10.0.0.26 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 9 May 01 18:42:53 volumioa sudo[8665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 18:42:53 volumioa sudo[8665]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:53 volumioa sudo[8665]: pam_unix(sudo:session): session closed for user root May 01 18:42:53 volumioa sudo[8668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 18:42:53 volumioa sudo[8668]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:53 volumioa sudo[8668]: pam_unix(sudo:session): session closed for user root May 01 18:42:53 volumioa sudo[8671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 01 18:42:53 volumioa sudo[8671]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:53 volumioa sudo[8671]: pam_unix(sudo:session): session closed for user root May 01 18:42:53 volumioa volumio[8543]: info: Upmpdcli Daemon Started May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetVisibleSources May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetState May 01 18:42:53 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetQueue May 01 18:42:53 volumioa volumio[8543]: info: CoreStateMachine::getQueue May 01 18:42:53 volumioa volumio[8543]: info: CorePlayQueue::getQueue May 01 18:42:53 volumioa volumio[8543]: info: Listing playlists May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 18:42:53 volumioa volumio[8543]: info: Received Get System Info May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 18:42:53 volumioa volumio[8543]: info: Discovery: Getting this device information May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetState May 01 18:42:53 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetState May 01 18:42:53 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 01 18:42:53 volumioa volumio[8543]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 18:42:54 volumioa volumio[8543]: info: Cannot mount NAS Nas at system boot, trial number 3 ,retrying in 5 seconds May 01 18:42:54 volumioa volumio[8543]: info: Cannot mount NAS Media at system boot, trial number 3 ,retrying in 5 seconds May 01 18:42:54 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 18:42:54 volumioa volumio[8543]: info: Received Get System Info May 01 18:42:54 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 18:42:54 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 18:42:54 volumioa volumio[8543]: info: Discovery: Getting this device information May 01 18:42:54 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetState May 01 18:42:54 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:54 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 18:42:55 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 01 18:42:55 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 18:42:55 volumioa volumio[8543]: info: Received Get System Info May 01 18:42:55 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 18:42:55 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 18:42:55 volumioa volumio[8543]: info: Discovery: Getting this device information May 01 18:42:55 volumioa volumio[8543]: info: CoreCommandRouter::volumioGetState May 01 18:42:55 volumioa volumio[8543]: info: CorePlayQueue::getTrack 0 May 01 18:42:55 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 18:42:55 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 01 18:42:59 volumioa volumio[8543]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 01 18:42:59 volumioa volumio[8543]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 18:42:59 volumioa volumio[8543]: TypeError: Cannot read property 'length' of undefined May 01 18:42:59 volumioa volumio[8543]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 01 18:42:59 volumioa volumio[8543]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 01 18:42:59 volumioa volumio[8543]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 01 18:42:59 volumioa volumio[8543]: at Parser.emit (events.js:315:20) May 01 18:42:59 volumioa volumio[8543]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 01 18:42:59 volumioa volumio[8543]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 01 18:42:59 volumioa volumio[8543]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 01 18:42:59 volumioa volumio[8543]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 01 18:42:59 volumioa volumio[8543]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 01 18:42:59 volumioa volumio[8543]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 01 18:42:59 volumioa volumio[8543]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 01 18:42:59 volumioa volumio[8543]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 01 18:42:59 volumioa volumio[8543]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 01 18:42:59 volumioa volumio[8543]: at IncomingMessage.emit (events.js:327:22) May 01 18:42:59 volumioa volumio[8543]: at endReadableNT (internal/streams/readable.js:1327:12) May 01 18:42:59 volumioa volumio[8543]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 01 18:42:59 volumioa volumio[8543]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 18:42:59 volumioa sudo[8683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 18:41 May 01 18:42:59 volumioa sudo[8683]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:42:59 volumioa sudo[8683]: pam_unix(sudo:session): session closed for user root May 01 18:42:59 volumioa volumio-remote-updater[19683]: [2024-05-01 18:42:59] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 01 18:42:59 volumioa volumio-remote-updater[19683]: [2024-05-01 18:42:59] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 01 18:42:59 volumioa systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 01 18:42:59 volumioa systemd[1]: volumio.service: Failed with result 'exit-code'. May 01 18:42:59 volumioa systemd[1]: Started dynamicswap service. May 01 18:42:59 volumioa systemd[1]: dynamicswap.service: Succeeded. May 01 18:43:00 volumioa systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 01 18:43:00 volumioa systemd[1]: volumio.service: Scheduled restart job, restart counter is at 6. May 01 18:43:00 volumioa systemd[1]: Stopped Volumio Backend Module. May 01 18:43:00 volumioa systemd[1]: Started Volumio Backend Module. May 01 18:43:00 volumioa systemd[1]: Started dynamicswap service. May 01 18:43:00 volumioa systemd[1]: dynamicswap.service: Succeeded. May 01 18:43:01 volumioa volumio[8694]: info: ------------------------------------------- May 01 18:43:01 volumioa volumio[8694]: info: ----- Volumio3 ---- May 01 18:43:01 volumioa volumio[8694]: info: ------------------------------------------- May 01 18:43:01 volumioa volumio[8694]: info: ----- System startup ---- May 01 18:43:01 volumioa volumio[8694]: info: ------------------------------------------- May 01 18:43:01 volumioa volumio[8694]: info: MYVOLUMIO Environment detected May 01 18:43:01 volumioa volumio[8694]: info: Plugin folders cleanup May 01 18:43:01 volumioa volumio[8694]: info: Scanning into folder /volumio/app/plugins/ May 01 18:43:01 volumioa volumio[8694]: info: Scanning category audio_interface May 01 18:43:01 volumioa volumio[8694]: info: Scanning category miscellanea May 01 18:43:01 volumioa volumio[8694]: info: Scanning category music_service May 01 18:43:01 volumioa volumio[8694]: info: Scanning category plugins.json May 01 18:43:01 volumioa volumio[8694]: info: Scanning category system_controller May 01 18:43:01 volumioa volumio[8694]: info: Scanning category user_interface May 01 18:43:01 volumioa volumio[8694]: info: Scanning into folder /data/plugins/ May 01 18:43:01 volumioa volumio[8694]: info: Scanning category audio_interface May 01 18:43:01 volumioa volumio[8694]: info: Scanning category music_service May 01 18:43:01 volumioa volumio[8694]: info: Scanning category system_controller May 01 18:43:01 volumioa volumio[8694]: info: Scanning category system_hardware May 01 18:43:01 volumioa volumio[8694]: info: Scanning category user_interface May 01 18:43:01 volumioa volumio[8694]: info: Plugin folders cleanup completed May 01 18:43:01 volumioa volumio[8694]: info: ------------------------------------------- May 01 18:43:01 volumioa volumio[8694]: info: ----- Core plugins startup ---- May 01 18:43:01 volumioa volumio[8694]: info: ------------------------------------------- May 01 18:43:01 volumioa volumio[8694]: info: Loading plugins from folder /volumio/app/plugins/ May 01 18:43:01 volumioa volumio[8694]: info: Adding plugin upnp to MyMusic Plugins May 01 18:43:01 volumioa volumio[8694]: info: Adding plugin airplay_emulation to MyMusic Plugins May 01 18:43:01 volumioa volumio[8694]: info: Adding plugin upnp_browser to MyMusic Plugins May 01 18:43:01 volumioa volumio[8694]: info: Loading plugins from folder /data/plugins/ May 01 18:43:01 volumioa volumio[8694]: info: Loading plugin "system"... May 01 18:43:01 volumioa volumio[8694]: info: Loading plugin "appearance"... May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "network"... May 01 18:43:02 volumioa volumio[8694]: info: Refreshing Cached IP Addresses May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "services"... May 01 18:43:02 volumioa sudo[8722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 18:43:02 volumioa sudo[8722]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "alsa_controller"... May 01 18:43:02 volumioa sudo[8722]: pam_unix(sudo:session): session closed for user root May 01 18:43:02 volumioa sudo[8724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 18:43:02 volumioa sudo[8724]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:43:02 volumioa sudo[8724]: pam_unix(sudo:session): session closed for user root May 01 18:43:02 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "wizard"... May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "networkfs"... May 01 18:43:02 volumioa volumio[8694]: info: Cannot mount NAS Nas at system boot, trial number 1 ,retrying in 5 seconds May 01 18:43:02 volumioa volumio[8694]: info: Cannot mount NAS Media at system boot, trial number 1 ,retrying in 5 seconds May 01 18:43:02 volumioa volumio[8694]: info: Starting Udev Watcher for removable devices May 01 18:43:02 volumioa volumio[8694]: info: Ignoring mount for partition: boot May 01 18:43:02 volumioa volumio[8694]: info: Ignoring mount for partition: volumio May 01 18:43:02 volumioa volumio[8694]: info: Ignoring mount for partition: volumio_data May 01 18:43:02 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "volumio_command_line_client"... May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "upnp"... May 01 18:43:02 volumioa volumio[8694]: info: [1714603382464] Starting Upmpd Daemon May 01 18:43:02 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "my_music"... May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "mpd"... May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "upnp_browser"... May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "alarm-clock"... May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "airplay_emulation"... May 01 18:43:02 volumioa volumio[8694]: info: Starting Shairport Sync May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "last_100"... May 01 18:43:02 volumioa volumio[8694]: info: Loading plugin "webradio"... May 01 18:43:03 volumioa volumio[8694]: info: Loading plugin "i2s_dacs"... May 01 18:43:03 volumioa volumio[8694]: info: I2S DAC not set, start Auto-detection May 01 18:43:03 volumioa volumio[8694]: info: Loading plugin "volumiodiscovery"... May 01 18:43:03 volumioa volumio[8694]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 01 18:43:03 volumioa volumio[8694]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 18:43:03 volumioa node[8694]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 01 18:43:03 volumioa volumio[8694]: *** WARNING *** For more information see May 01 18:43:03 volumioa volumio[8694]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 01 18:43:03 volumioa volumio[8694]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 18:43:03 volumioa volumio[8694]: *** WARNING *** For more information see May 01 18:43:03 volumioa node[8694]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 18:43:03 volumioa node[8694]: *** WARNING *** For more information see May 01 18:43:03 volumioa node[8694]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 01 18:43:03 volumioa node[8694]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 18:43:03 volumioa node[8694]: *** WARNING *** For more information see May 01 18:43:03 volumioa volumio[8694]: info: Applying required configuration parameters for plugin volumiodiscovery May 01 18:43:03 volumioa volumio[8694]: info: Discovery: Started advertising with name: VolumioA May 01 18:43:03 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 18:43:03 volumioa volumio[8694]: info: Loading plugin "spop"... May 01 18:43:03 volumioa volumio[8694]: info: Loading plugin "youtube2"... May 01 18:43:04 volumioa volumio[8694]: info: Loading plugin "ytcr"... May 01 18:43:04 volumioa volumio-remote-updater[19683]: [2024-05-01 18:43:04] [connect] Successful connection May 01 18:43:05 volumioa volumio[8694]: info: Loading plugin "ytmusic"... May 01 18:43:06 volumioa volumio[8694]: info: Loading plugin "autostart"... May 01 18:43:06 volumioa volumio[8694]: info: Applying required configuration parameters for plugin autostart May 01 18:43:06 volumioa volumio[8694]: info: AutoStart - onVolumioStart - read config.json May 01 18:43:06 volumioa volumio[8694]: info: Loading plugin "now_playing"... May 01 18:43:06 volumioa volumio[8694]: info: Loading plugin "outputs"... May 01 18:43:06 volumioa volumio[8694]: info: Loading plugin "albumart"... May 01 18:43:06 volumioa volumio[8694]: info: Plugin example_plugin is not enabled May 01 18:43:06 volumioa volumio[8694]: info: Loading plugin "inputs"... May 01 18:43:06 volumioa volumio[8694]: info: Loading plugin "updater_comm"... May 01 18:43:06 volumioa volumio[8694]: info: Plugin mpdemulation is not enabled May 01 18:43:06 volumioa volumio[8694]: info: Loading plugin "rest_api"... May 01 18:43:06 volumioa volumio[8694]: info: Loading plugin "websocket"... May 01 18:43:06 volumioa volumio[8694]: info: Loading plugin "fusiondsp"... May 01 18:43:07 volumioa volumio[8694]: Forking 3 albumart workers May 01 18:43:07 volumioa volumio[8694]: info: Applying required configuration parameters for plugin fusiondsp May 01 18:43:07 volumioa volumio[8694]: info: Loading plugin "volusonic"... May 01 18:43:07 volumioa volumio[8694]: Starting albumart workers May 01 18:43:07 volumioa volumio[8694]: Starting albumart workers May 01 18:43:07 volumioa volumio[8694]: Starting albumart workers May 01 18:43:07 volumioa volumio[8694]: info: Applying required configuration parameters for plugin volusonic May 01 18:43:07 volumioa volumio[8694]: info: Loading plugin "backup_restore"... May 01 18:43:08 volumioa volumio[8694]: info: Applying required configuration parameters for plugin backup_restore May 01 18:43:08 volumioa volumio[8694]: info: Plugin music_services_shield is not enabled May 01 18:43:08 volumioa volumio[8694]: info: Loading plugin "Systeminfo"... May 01 18:43:08 volumioa volumio[8694]: info: Loading plugin "randomizer"... May 01 18:43:08 volumioa volumio[8694]: info: Applying required configuration parameters for plugin randomizer May 01 18:43:08 volumioa volumio[8694]: info: Loading plugin "touch_display"... May 01 18:43:08 volumioa volumio[8694]: info: Applying required configuration parameters for plugin touch_display May 01 18:43:08 volumioa volumio[8694]: info: Loading i18n strings for locale en May 01 18:43:08 volumioa volumio[8694]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored. May 01 18:43:08 volumioa volumio[8694]: Updating browse sources language May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::initPlayerControls May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 18:43:08 volumioa volumio[8694]: Express server listening on port 3000 May 01 18:43:08 volumioa volumio[8694]: [Metrics] WebUI: 8s 62.08ms May 01 18:43:08 volumioa volumio[8694]: info: CoreStateMachine::resetVolumioState May 01 18:43:08 volumioa volumio[8694]: info: CoreStateMachine::getcurrentVolume May 01 18:43:08 volumioa volumio[8694]: info: CoreCommandRouter::volumioRetrievevolume May 01 18:43:09 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 18:43:09 volumioa volumio[8694]: info: Cannot mount NAS Nas at system boot, trial number 2 ,retrying in 5 seconds May 01 18:43:09 volumioa volumio[8694]: info: Cannot mount NAS Media at system boot, trial number 2 ,retrying in 5 seconds May 01 18:43:09 volumioa volumio[8694]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 1 May 01 18:43:09 volumioa volumio[8694]: verbose: New Socket.io Connection to 10.0.0.139 from 10.0.0.26 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 2 May 01 18:43:09 volumioa volumio[8694]: verbose: New Socket.io Connection to 10.0.0.139 from 10.0.0.26 UA: unknown Total Clients: 3 May 01 18:43:09 volumioa volumio[8694]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 4 May 01 18:43:09 volumioa volumio[8694]: verbose: New Socket.io Connection to 10.0.0.139 from 10.0.0.26 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 5 May 01 18:43:09 volumioa volumio-remote-updater[19683]: [2024-05-01 18:43:09] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714603384 101 May 01 18:43:09 volumioa volumio[8694]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 6 May 01 18:43:09 volumioa volumio[8694]: verbose: New Socket.io Connection to 10.0.0.139 from 10.0.0.26 UA: unknown Total Clients: 7 May 01 18:43:09 volumioa volumio[8694]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 8 May 01 18:43:09 volumioa volumio[8694]: info: CoreStateMachine::pushState May 01 18:43:09 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:09 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:43:09 volumioa volumio[8694]: info: CoreCommandRouter::volumioPushState May 01 18:43:09 volumioa volumio[8694]: info: CoreStateMachine::updateTrackBlock May 01 18:43:09 volumioa volumio[8694]: info: CorePlayQueue::getTrackBlock May 01 18:43:09 volumioa volumio[8694]: info: CoreCommandRouter::volumioRetrievevolume May 01 18:43:09 volumioa volumio[8694]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 May 01 18:43:09 volumioa volumio[8694]: info: Reloading queue from file May 01 18:43:09 volumioa volumio[8694]: info: CoreStateMachine::pushState May 01 18:43:09 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:09 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:43:09 volumioa volumio[8694]: info: CoreCommandRouter::volumioPushState May 01 18:43:09 volumioa volumio[8694]: info: CoreStateMachine::setRepeat true single undefined May 01 18:43:09 volumioa volumio[8694]: info: CoreStateMachine::pushState May 01 18:43:09 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:09 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:43:09 volumioa volumio[8694]: info: CoreCommandRouter::volumioPushState May 01 18:43:09 volumioa volumio[8694]: info: CoreStateMachine::setRandom true May 01 18:43:09 volumioa volumio[8694]: info: CoreStateMachine::pushState May 01 18:43:09 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:09 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 18:43:09 volumioa volumio[8694]: info: CoreCommandRouter::volumioPushState May 01 18:43:09 volumioa volumio[8694]: info: Setting Device type: Raspberry PI May 01 18:43:09 volumioa volumio[8694]: info: Discovery: adding 39de326e-0c8d-49e6-ad8a-8e06195d9e03 May 01 18:43:09 volumioa volumio[8694]: info: Discovery: Found device VolumioA May 01 18:43:09 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:09 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:10 volumioa volumio[8694]: verbose: New Socket.io Connection to 10.0.0.139 from 10.0.0.26 UA: unknown Total Clients: 8 May 01 18:43:11 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:11 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:12 volumioa sudo[8805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 18:43:12 volumioa sudo[8805]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:43:12 volumioa sudo[8805]: pam_unix(sudo:session): session closed for user root May 01 18:43:12 volumioa sudo[8808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 18:43:12 volumioa sudo[8808]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:43:12 volumioa sudo[8808]: pam_unix(sudo:session): session closed for user root May 01 18:43:12 volumioa sudo[8811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 01 18:43:12 volumioa sudo[8811]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:43:12 volumioa sudo[8811]: pam_unix(sudo:session): session closed for user root May 01 18:43:12 volumioa volumio[8694]: info: Upmpdcli Daemon Started May 01 18:43:13 volumioa sudo[8814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 18:43:13 volumioa sudo[8814]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:43:13 volumioa sudo[8814]: pam_unix(sudo:session): session closed for user root May 01 18:43:13 volumioa sudo[8817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 18:43:13 volumioa sudo[8817]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:43:13 volumioa sudo[8817]: pam_unix(sudo:session): session closed for user root May 01 18:43:13 volumioa volumio[8694]: verbose: New Socket.io Connection to 10.0.0.139 from 10.0.0.26 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 9 May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetVisibleSources May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:13 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 18:43:13 volumioa volumio[8694]: info: Received Get System Info May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 18:43:13 volumioa volumio[8694]: info: Discovery: Getting this device information May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:13 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:13 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:13 volumioa volumio[8694]: info: Listing playlists May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 01 18:43:13 volumioa volumio[8694]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 9 May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetVisibleSources May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:13 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 18:43:13 volumioa volumio[8694]: info: Received Get System Info May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 18:43:13 volumioa volumio[8694]: info: Discovery: Getting this device information May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:13 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 18:43:13 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:13 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:13 volumioa sudo[8820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 18:43:13 volumioa sudo[8820]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:43:13 volumioa sudo[8820]: pam_unix(sudo:session): session closed for user root May 01 18:43:14 volumioa sudo[8823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 18:43:14 volumioa sudo[8823]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 18:43:14 volumioa volumio[8694]: info: Cannot mount NAS Nas at system boot, trial number 3 ,retrying in 5 seconds May 01 18:43:14 volumioa volumio[8694]: info: Cannot mount NAS Media at system boot, trial number 3 ,retrying in 5 seconds May 01 18:43:14 volumioa sudo[8823]: pam_unix(sudo:session): session closed for user root May 01 18:43:14 volumioa volumio[8694]: info: Listing playlists May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 18:43:14 volumioa volumio[8694]: verbose: New Socket.io Connection to 10.0.0.139 from 10.0.0.26 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 10 May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetVisibleSources May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:14 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetQueue May 01 18:43:14 volumioa volumio[8694]: info: CoreStateMachine::getQueue May 01 18:43:14 volumioa volumio[8694]: info: CorePlayQueue::getQueue May 01 18:43:14 volumioa volumio[8694]: info: Listing playlists May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 18:43:14 volumioa volumio[8694]: info: Received Get System Info May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 18:43:14 volumioa volumio[8694]: info: Discovery: Getting this device information May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:14 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:14 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 01 18:43:14 volumioa volumio[8694]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 18:43:15 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 18:43:15 volumioa volumio[8694]: info: Received Get System Info May 01 18:43:15 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 18:43:15 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 18:43:15 volumioa volumio[8694]: info: Discovery: Getting this device information May 01 18:43:15 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:15 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:15 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 18:43:16 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 01 18:43:16 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 18:43:16 volumioa volumio[8694]: info: Received Get System Info May 01 18:43:16 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 18:43:16 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 18:43:16 volumioa volumio[8694]: info: Discovery: Getting this device information May 01 18:43:16 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:16 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:16 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 18:43:17 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 01 18:43:19 volumioa volumio[8694]: info: Cannot mount NAS Nas at system boot, trial number 4 ,retrying in 5 seconds May 01 18:43:19 volumioa volumio[8694]: info: Cannot mount NAS Media at system boot, trial number 4 ,retrying in 5 seconds May 01 18:43:24 volumioa volumio[8694]: info: Cannot mount NAS at system boot, trial number 4 ,stopping May 01 18:43:24 volumioa volumio[8694]: info: Cannot mount NAS at system boot, trial number 4 ,stopping May 01 18:43:32 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 01 18:43:32 volumioa volumio[8694]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 01 18:43:32 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 01 18:43:32 volumioa volumio[8694]: info: Received Get System Version May 01 18:43:32 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 01 18:43:32 volumioa volumio[8694]: info: Received Get System Info May 01 18:43:32 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 18:43:32 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 18:43:32 volumioa volumio[8694]: info: Discovery: Getting this device information May 01 18:43:32 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:32 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:32 volumioa volumio[8694]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 18:43:32 volumioa volumio[8694]: info: CoreCommandRouter::volumioGetState May 01 18:43:32 volumioa volumio[8694]: info: CorePlayQueue::getTrack 0 May 01 18:43:37 volumioa volumio[8694]: info: Preload queue cleared May 01 18:43:37 volumioa volumio[8694]: info: Preloading song: mnt/NAS/Nas/50 cent/The Massacre/07 Candy Shop (Feat. Olivia) (Produced By Scott Storch).mp3 May 01 18:43:37 volumioa volumio[8694]: info: Preloading song: mnt/NAS/Nas/50 cent/The Massacre/07 Candy Shop (Feat. Olivia) (Produced By Scott Storch).mp3 May 01 18:43:37 volumioa volumio[8694]: info: Preloading song: mnt/NAS/Nas/50 cent/The Massacre/07 Candy Shop (Feat. Olivia) (Produced By Scott Storch).mp3 May 01 18:43:37 volumioa volumio[8694]: info: Preloading song: mnt/NAS/Nas/50 cent/The Massacre/08 Outta Control (Produced By Dr. Dre & Mike Elizondo.mp3 May 01 18:43:37 volumioa volumio[8694]: info: Preloading song: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22yqpZ8_6jjT0%22%2C%22params%22%3A%22qgMGSGkgcmVzugMLCNy96pXx6Nuw-AG6AyQSIlBMNVZjdy1YTTc2dkdaYy1GdzJQeUtfXzdQZXVJTEg2emK6AwoItYaIs6Hfu5QUugMKCOiIsc3k-qOTZ7oDCwj-7Ymuhp7v3OgBugMLCP_LlZqK5ffQ0AG6AyQSIlBMNVZjdy1YTTc2dkhjSEw3YTVXaU54b09BZVkwaUFnS2G6AwsI2-TqzumeiN2xAboDCgigxJ-7hM6ljQe6Aw8SDVJELUdGdlJ4SzZudHe6AwoIkdTO5ezJwoQtugMKCNbGxLi9qa6WBboDCwiP2MSo2Zzt5IwBugMLCKGqvrGA3Pnp_gG6AwoI0pvn2LXVkdN5ugMLCIqTrILttviK1gG6AwoI3PiVr73S4LxHugMKCNbXiK7L_LrfMroDCwjAybma3ridwf0B8gMFDWTIAT-CBAIQAQ%253D%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Hi%20Res%20Music%2032%20Bit%20-%20Impression%20Audiophile%20Collection%20-%20Audiophile%20Jazz%22%2C%22artist%22%3A%22Audiophile%20Jazz%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FyqpZ8_6jjT0%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLC6G-SyGwito3cJcSlWYAyjOb0ZNA%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22yqpZ8_6jjT0%22%2C%22params%22%3A%22qgMGSGkgcmVzugMLCNy96pXx6Nuw-AG6AyQSIlBMNVZjdy1YTTc2dkdaYy1GdzJQeUtfXzdQZXVJTEg2emK6AwoItYaIs6Hfu5QUugMKCOiIsc3k-qOTZ7oDCwj-7Ymuhp7v3OgBugMLCP_LlZqK5ffQ0AG6AyQSIlBMNVZjdy1YTTc2dkhjSEw3YTVXaU54b09BZVkwaUFnS2G6AwsI2-TqzumeiN2xAboDCgigxJ-7hM6ljQe6Aw8SDVJELUdGdlJ4SzZudHe6AwoIkdTO5ezJwoQtugMKCNbGxLi9qa6WBboDCwiP2MSo2Zzt5IwBugMLCKGqvrGA3Pnp_gG6AwoI0pvn2LXVkdN5ugMLCIqTrILttviK1gG6AwoI3PiVr73S4LxHugMKCNbXiK7L_LrfMroDCwjAybma3ridwf0B8gMFDWTIAT-CBAIQAQ%253D%253D%22%7D%7D%7D May 01 18:43:37 volumioa volumio[8694]: info: Preloading song: upnp/http://10.0.0.4:32469/ContentDirectory/6d0f326a-0b79-aacc-4f36-22f050da97fe/control.xml@cac130284d37855a164b May 01 18:43:37 volumioa volumio[8694]: info: Preloading song: upnp/http://10.0.0.4:32469/ContentDirectory/6d0f326a-0b79-aacc-4f36-22f050da97fe/control.xml@175127d35967102ba88b May 01 18:43:37 volumioa volumio[8694]: info: Preloading song: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22mLND8z3kCvM%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%224K%20Cozy%20Coffee%20Cabin%20Ambience%20%E2%98%95%20Smooth%20Piano%20Jazz%20Music%20for%20Relaxing%2C%20Studying%20and%20Working%22%2C%22artist%22%3A%22Relaxing%20Jazz%20Piano%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FmLND8z3kCvM%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLDNPD-C-AiTicP_OzuG9ClwytJf-g%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22mLND8z3kCvM%22%7D%7D%7D May 01 18:43:38 volumioa volumio[8694]: info: Exploding uri mnt/NAS/Nas/50 cent/The Massacre/07 Candy Shop (Feat. Olivia) (Produced By Scott Storch).mp3 in service mpd May 01 18:43:38 volumioa volumio[8694]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 18:43:38 volumioa volumio[8694]: TypeError: Cannot read property 'then' of undefined May 01 18:43:38 volumioa volumio[8694]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) May 01 18:43:38 volumioa volumio[8694]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) May 01 18:43:38 volumioa volumio[8694]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16) May 01 18:43:38 volumioa volumio[8694]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) May 01 18:43:38 volumioa volumio[8694]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) May 01 18:43:38 volumioa volumio[8694]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100) May 01 18:43:38 volumioa volumio[8694]: at listOnTimeout (internal/timers.js:554:17) May 01 18:43:38 volumioa volumio[8694]: at processTimers (internal/timers.js:497:7) May 01 18:43:38 volumioa volumio[8694]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 18:43:38 volumioa sudo[8881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 18:42 May 01 18:43:38 volumioa sudo[8881]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"