-- Logs begin at Mon 2025-06-09 14:54:06 UTC, end at Mon 2025-06-09 16:50:13 UTC. -- Jun 09 16:49:02 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:49:02 volumio volumio[14742]: info: CURURI: albums:// Jun 09 16:49:02 volumio volumio[14742]: listAlbums - loading Albums from cache Jun 09 16:49:05 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:49:05 volumio volumio[14742]: info: CURURI: music-library Jun 09 16:49:06 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:49:06 volumio volumio[14742]: info: CURURI: music-library/NAS Jun 09 16:49:06 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:49:06 volumio volumio[14742]: info: CURURI: music-library/NAS/CD Jun 09 16:49:08 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:49:08 volumio volumio[14742]: info: CURURI: music-library/NAS/CD/[EAC]機動戦士ガンダムSEED DESTINY ORIGINAL SOUNDTRACK IV(WAV+CUE+LOG) Jun 09 16:49:13 volumio volumio[14742]: info: CoreCommandRouter::volumioAddQueueItems Jun 09 16:49:13 volumio volumio[14742]: info: CoreStateMachine::addQueueItems Jun 09 16:49:13 volumio volumio[14742]: info: CorePlayQueue::addQueueItems Jun 09 16:49:13 volumio volumio[14742]: info: Adding Item to queue: music-library/NAS/CD/[EAC]機動戦士ガンダムSEED DESTINY ORIGINAL SOUNDTRACK IV(WAV+CUE+LOG)/CDImage.cue Jun 09 16:49:13 volumio volumio[14742]: info: Exploding uri music-library/NAS/CD/[EAC]機動戦士ガンダムSEED DESTINY ORIGINAL SOUNDTRACK IV(WAV+CUE+LOG)/CDImage.cue in service mpd Jun 09 16:49:22 volumio volumio[14742]: info: CorePlayQueue::saveQueue Jun 09 16:49:22 volumio volumio[14742]: info: CoreCommandRouter::volumioPushQueue Jun 09 16:49:22 volumio volumio[14742]: info: CoreStateMachine::updateTrackBlock Jun 09 16:49:22 volumio volumio[14742]: info: CorePlayQueue::getTrackBlock Jun 09 16:49:22 volumio volumio[14742]: info: CoreCommandRouter::volumioPlay Jun 09 16:49:22 volumio volumio[14742]: UNSET VOLATILE Jun 09 16:49:22 volumio volumio[14742]: info: CoreStateMachine::play index 0 Jun 09 16:49:22 volumio volumio[14742]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:49:22 volumio volumio[14742]: info: CoreStateMachine::stop Jun 09 16:49:22 volumio volumio[14742]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:49:22 volumio volumio[14742]: UNSET VOLATILE Jun 09 16:49:22 volumio volumio[14742]: info: CoreStateMachine::play index undefined Jun 09 16:49:22 volumio volumio[14742]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 16:49:22 volumio volumio[14742]: info: CorePlayQueue::getTrack 0 Jun 09 16:49:22 volumio volumio[14742]: info: CoreStateMachine::startPlaybackTimer Jun 09 16:49:22 volumio volumio[14742]: info: CorePlayQueue::getTrack 0 Jun 09 16:49:22 volumio volumio[14742]: info: ControllerMpd::sendMpdCommand stop Jun 09 16:49:22 volumio volumio[14742]: info: sending command... Jun 09 16:49:22 volumio volumio[14742]: info: parsing response... Jun 09 16:49:22 volumio volumio[14742]: info: ControllerMpd::sendMpdCommand clear Jun 09 16:49:22 volumio volumio[14742]: info: sending command... Jun 09 16:49:22 volumio volumio[14742]: info: Jun 09 16:49:22 volumio volumio[14742]: ---------------------------- MPD announces system playlist update Jun 09 16:49:22 volumio volumio[14742]: info: Ignoring MPD Status Update Jun 09 16:49:22 volumio volumio[14742]: info: parsing response... Jun 09 16:49:22 volumio volumio[14742]: info: ControllerMpd::sendMpdCommand load "NAS/CD/[EAC]機動戦士ガンダムSEED DESTINY ORIGINAL SOUNDTRACK IV(WAV+CUE+LOG)/CDImage.cue" Jun 09 16:49:22 volumio volumio[14742]: info: sending command... Jun 09 16:49:22 volumio volumio[14742]: info: null Jun 09 16:49:22 volumio volumio[14742]: info: ------------------------------ 107ms Jun 09 16:49:22 volumio volumio[14742]: info: Jun 09 16:49:22 volumio volumio[14742]: ---------------------------- MPD announces system playlist update Jun 09 16:49:22 volumio volumio[14742]: info: Ignoring MPD Status Update Jun 09 16:49:22 volumio volumio[14742]: info: parsing response... Jun 09 16:49:22 volumio volumio[14742]: info: ControllerMpd::sendMpdCommand play Jun 09 16:49:22 volumio volumio[14742]: info: sending command... Jun 09 16:49:22 volumio volumio[14742]: info: ------------------------------ 93ms Jun 09 16:49:22 volumio volumio[14742]: info: parsing response... Jun 09 16:49:22 volumio volumio[14742]: info: Jun 09 16:49:23 volumio volumio[14742]: ---------------------------- MPD announces state update: player Jun 09 16:49:23 volumio kernel: bcm2835-i2s 20203000.i2s: I2S SYNC error! Jun 09 16:49:23 volumio volumio[14742]: info: ControllerMpd::getState Jun 09 16:49:23 volumio volumio[14742]: info: ControllerMpd::sendMpdCommand status Jun 09 16:49:23 volumio volumio[14742]: info: sending command... Jun 09 16:49:23 volumio volumio[14742]: info: Jun 09 16:49:23 volumio volumio[14742]: ---------------------------- MPD announces state update: player Jun 09 16:49:23 volumio volumio[14742]: info: ControllerMpd::getState Jun 09 16:49:23 volumio volumio[14742]: info: ControllerMpd::sendMpdCommand status Jun 09 16:49:23 volumio volumio[14742]: info: parsing response... Jun 09 16:49:23 volumio volumio[14742]: info: sending command... Jun 09 16:49:23 volumio volumio[14742]: info: ControllerMpd::parseState Jun 09 16:49:23 volumio volumio[14742]: info: ControllerMpd::sendMpdCommand playlistinfo Jun 09 16:49:23 volumio volumio[14742]: info: sending command... Jun 09 16:49:23 volumio volumio[14742]: info: parsing response... Jun 09 16:49:23 volumio volumio[14742]: info: parsing response... Jun 09 16:49:23 volumio volumio[14742]: info: ControllerMpd::parseState Jun 09 16:49:23 volumio volumio[14742]: info: ControllerMpd::sendMpdCommand playlistinfo Jun 09 16:49:23 volumio volumio[14742]: info: ControllerMpd::parseTrackInfo Jun 09 16:49:23 volumio volumio[14742]: info: sending command... Jun 09 16:49:23 volumio volumio[14742]: info: ControllerMpd::pushState Jun 09 16:49:23 volumio volumio[14742]: info: CoreCommandRouter::servicePushState Jun 09 16:49:23 volumio volumio[14742]: info: CoreStateMachine::syncState Jun 09 16:49:23 volumio volumio[14742]: info: CorePlayQueue::getTrack 0 Jun 09 16:49:23 volumio volumio[14742]: info: STATE SERVICE {"status":"play","position":0,"seek":371,"duration":96,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"最後の征戦 ～怒り","artist":null,"album":"機動戦士ガンダムSEED DESTINY OST4","uri":"NAS/CD/[EAC]機動戦士ガンダムSEED DESTINY ORIGINAL SOUNDTRACK IV(WAV+CUE+LOG)/CDImage.wav","trackType":"wav"} Jun 09 16:49:23 volumio volumio[14742]: info: CURRENT POSITION 0 Jun 09 16:49:23 volumio volumio[14742]: info: CoreStateMachine::syncState stateService play Jun 09 16:49:23 volumio volumio[14742]: info: CoreStateMachine::syncState currentStatus stop Jun 09 16:49:23 volumio volumio[14742]: info: CoreStateMachine::pushState Jun 09 16:49:23 volumio volumio[14742]: info: CoreStateMachine::getState Jun 09 16:49:23 volumio volumio[14742]: info: CorePlayQueue::getTrack 0 Jun 09 16:49:23 volumio volumio[14742]: info: CoreCommandRouter::volumioPushState Jun 09 16:49:23 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 16:49:23 volumio volumio[14742]: info: ------------------------------ 792ms Jun 09 16:49:23 volumio volumio[14742]: info: parsing response... Jun 09 16:49:23 volumio volumio[14742]: info: ControllerMpd::parseTrackInfo Jun 09 16:49:23 volumio volumio[14742]: info: ControllerMpd::pushState Jun 09 16:49:23 volumio volumio[14742]: info: CoreCommandRouter::servicePushState Jun 09 16:49:23 volumio volumio[14742]: info: CoreStateMachine::syncState Jun 09 16:49:23 volumio volumio[14742]: info: CorePlayQueue::getTrack 0 Jun 09 16:49:23 volumio volumio[14742]: info: STATE SERVICE {"status":"play","position":0,"seek":534,"duration":96,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"最後の征戦 ～怒り","artist":null,"album":"機動戦士ガンダムSEED DESTINY OST4","uri":"NAS/CD/[EAC]機動戦士ガンダムSEED DESTINY ORIGINAL SOUNDTRACK IV(WAV+CUE+LOG)/CDImage.wav","trackType":"wav"} Jun 09 16:49:23 volumio volumio[14742]: info: CURRENT POSITION 0 Jun 09 16:49:23 volumio volumio[14742]: info: CoreStateMachine::syncState stateService play Jun 09 16:49:23 volumio volumio[14742]: info: CoreStateMachine::syncState currentStatus play Jun 09 16:49:23 volumio volumio[14742]: info: Received an update from plugin. extracting info from payload Jun 09 16:49:23 volumio volumio[14742]: info: CoreStateMachine::pushState Jun 09 16:49:23 volumio volumio[14742]: info: CoreStateMachine::getState Jun 09 16:49:23 volumio volumio[14742]: info: CorePlayQueue::getTrack 0 Jun 09 16:49:23 volumio volumio[14742]: info: CoreCommandRouter::volumioPushState Jun 09 16:49:23 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 16:49:23 volumio volumio[14742]: info: CoreStateMachine::pushState Jun 09 16:49:23 volumio volumio[14742]: info: CoreStateMachine::getState Jun 09 16:49:24 volumio volumio[14742]: info: CorePlayQueue::getTrack 0 Jun 09 16:49:24 volumio volumio[14742]: info: CoreCommandRouter::volumioPushState Jun 09 16:49:24 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 16:49:24 volumio volumio[14742]: info: ------------------------------ 877ms Jun 09 16:49:32 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:49:32 volumio volumio[14742]: info: CURURI: artists:// Jun 09 16:49:33 volumio volumio[14742]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Taylor%20Swift/d9ba3f41-4c91-49f0-acf3-ddee5a752ee1.jpg' Jun 09 16:49:33 volumio volumio[14742]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/RADWIMPS/1ba83ccb-2e72-4482-af3f-adbbce75fa71.jpg' Jun 09 16:49:33 volumio volumio[14742]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Cat%20Empire/12c8dd80-ed4c-405e-a231-b40336259657.jpg' Jun 09 16:49:33 volumio volumio[14742]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%88%BF%E4%B8%9C%E7%9A%84%E7%8C%AB/4dd6ca28-579b-43f1-9452-09cae63c30da.jpg' Jun 09 16:49:33 volumio volumio[14742]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Various%20Artists/5bd4a48f-e8ee-4759-bad3-b222624c47ba.jpg' Jun 09 16:49:34 volumio volumio[14742]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Aselin%20Debison/97f14678-3251-400c-9b85-8c848e8c223f.jpg' Jun 09 16:49:34 volumio volumio[14742]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Camila%20Cabello/9f4b8fad-f7b9-4edf-86ea-ffa0a4239b2f.jpg' Jun 09 16:49:34 volumio volumio[14742]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dua%20Lipa/4a940b1b-7f52-43c4-9c8a-14c4e1a06ecf.jpg' Jun 09 16:49:34 volumio volumio[14742]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Imagine%20Dragons/e6cdeb15-7346-4690-beaa-cef2721a5326.jpg' Jun 09 16:49:42 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:49:42 volumio volumio[14742]: info: CURURI: music-library Jun 09 16:49:44 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:49:44 volumio volumio[14742]: info: CURURI: music-library/NAS Jun 09 16:49:45 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:49:45 volumio volumio[14742]: info: CURURI: music-library/NAS/CD Jun 09 16:49:49 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 09 16:49:49 volumio volumio[14742]: info: CURURI: music-library/NAS/CD/[EAC]機動戦士ガンダムSEED DESTINY ORIGINAL SOUNDTRACK IV(WAV+CUE+LOG) Jun 09 16:50:05 volumio volumio[14742]: info: CoreCommandRouter::volumioPause Jun 09 16:50:05 volumio volumio[14742]: info: CoreStateMachine::pause Jun 09 16:50:05 volumio volumio[14742]: info: CoreStateMachine::stPlaybackTimer Jun 09 16:50:05 volumio volumio[14742]: info: CoreStateMachine::servicePause Jun 09 16:50:05 volumio volumio[14742]: info: CorePlayQueue::getTrack 0 Jun 09 16:50:05 volumio volumio[14742]: info: CoreCommandRouter::servicePause Jun 09 16:50:05 volumio volumio[14742]: info: ControllerMpd::pause Jun 09 16:50:05 volumio volumio[14742]: info: ControllerMpd::sendMpdCommand pause Jun 09 16:50:05 volumio volumio[14742]: info: sending command... Jun 09 16:50:05 volumio volumio[14742]: info: Jun 09 16:50:05 volumio volumio[14742]: ---------------------------- MPD announces state update: player Jun 09 16:50:05 volumio volumio[14742]: info: parsing response... Jun 09 16:50:05 volumio volumio[14742]: info: ControllerMpd::getState Jun 09 16:50:05 volumio volumio[14742]: info: ControllerMpd::sendMpdCommand status Jun 09 16:50:05 volumio volumio[14742]: info: sending command... Jun 09 16:50:05 volumio volumio[14742]: info: parsing response... Jun 09 16:50:05 volumio volumio[14742]: info: ControllerMpd::parseState Jun 09 16:50:05 volumio volumio[14742]: info: ControllerMpd::sendMpdCommand playlistinfo Jun 09 16:50:05 volumio volumio[14742]: info: sending command... Jun 09 16:50:05 volumio volumio[14742]: info: parsing response... Jun 09 16:50:05 volumio volumio[14742]: info: ControllerMpd::parseTrackInfo Jun 09 16:50:05 volumio volumio[14742]: info: ControllerMpd::pushState Jun 09 16:50:05 volumio volumio[14742]: info: CoreCommandRouter::servicePushState Jun 09 16:50:05 volumio volumio[14742]: info: CoreStateMachine::syncState Jun 09 16:50:05 volumio volumio[14742]: info: CorePlayQueue::getTrack 0 Jun 09 16:50:05 volumio volumio[14742]: info: STATE SERVICE {"status":"pause","position":0,"seek":42864,"duration":96,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"最後の征戦 ～怒り","artist":null,"album":"機動戦士ガンダムSEED DESTINY OST4","uri":"NAS/CD/[EAC]機動戦士ガンダムSEED DESTINY ORIGINAL SOUNDTRACK IV(WAV+CUE+LOG)/CDImage.wav","trackType":"wav"} Jun 09 16:50:05 volumio volumio[14742]: info: CURRENT POSITION 0 Jun 09 16:50:05 volumio volumio[14742]: info: CoreStateMachine::syncState stateService pause Jun 09 16:50:05 volumio volumio[14742]: info: CoreStateMachine::syncState currentStatus pause Jun 09 16:50:05 volumio volumio[14742]: info: CoreStateMachine::pushState Jun 09 16:50:05 volumio volumio[14742]: info: CoreStateMachine::getState Jun 09 16:50:05 volumio volumio[14742]: info: CorePlayQueue::getTrack 0 Jun 09 16:50:05 volumio volumio[14742]: info: CoreCommandRouter::volumioPushState Jun 09 16:50:05 volumio volumio[14742]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 16:50:05 volumio volumio[14742]: info: CoreStateMachine::stPlaybackTimer Jun 09 16:50:05 volumio volumio[14742]: info: ------------------------------ 261ms Jun 09 16:50:08 volumio volumio[14742]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 09 16:50:08 volumio volumio[14742]: { Error: connect ETIMEDOUT 202.160.130.66:80 Jun 09 16:50:09 volumio volumio[14742]: at Object._errnoException (util.js:1022:11) Jun 09 16:50:09 volumio volumio[14742]: at _exceptionWithHostPort (util.js:1044:20) Jun 09 16:50:09 volumio volumio[14742]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jun 09 16:50:09 volumio volumio[14742]: code: 'ETIMEDOUT', Jun 09 16:50:09 volumio volumio[14742]: errno: 'ETIMEDOUT', Jun 09 16:50:09 volumio volumio[14742]: syscall: 'connect', Jun 09 16:50:09 volumio volumio[14742]: address: '202.160.130.66', Jun 09 16:50:09 volumio volumio[14742]: port: 80 } Jun 09 16:50:09 volumio volumio[14742]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 09 16:50:13 volumio sudo[15153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-09 16:49 Jun 09 16:50:13 volumio sudo[15153]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="ac2a0afddd424ea15d982b8c75eeec3a8648a313" VOLUMIO_FE_VERSION="700492006632ef61a5a17e6a3be4f37c790f883c" VOLUMIO_BE_VERSION="b2e85b2e8facd2d741f2fc40be426a34804b56fc" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue May 5 18:38:33 CEST 2020" VOLUMIO_VERSION="2.773" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="9e13d1d50d1f834c8c0294a226468074"