-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Mon 2025-12-29 18:47:38 UTC. -- Dec 29 18:46:03 darknight volumio[709]: info: CoreCommandRouter::volumioGetState Dec 29 18:46:03 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:46:12 darknight volumio[709]: Searching all installed plugins Dec 29 18:46:12 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:46:12 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: , search Dec 29 18:46:12 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 29 18:46:12 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Dec 29 18:46:12 darknight volumio[709]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Dec 29 18:46:13 darknight volumio[709]: info: CoreCommandRouter::volumioGetState Dec 29 18:46:13 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:46:13 darknight volumio[709]: info: Listing playlists Dec 29 18:46:13 darknight volumio[709]: info: Listing playlists Dec 29 18:46:14 darknight volumio[709]: info: All search sources collected, pushing search results Dec 29 18:46:23 darknight volumio[709]: info: CoreCommandRouter::volumioGetState Dec 29 18:46:23 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:46:33 darknight volumio[709]: info: CoreCommandRouter::volumioGetState Dec 29 18:46:33 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:46:33 darknight volumio[709]: info: Listing playlists Dec 29 18:46:33 darknight volumio[709]: info: Listing playlists Dec 29 18:46:43 darknight volumio[709]: info: CoreCommandRouter::volumioGetState Dec 29 18:46:43 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:46:53 darknight volumio[709]: info: CoreCommandRouter::volumioGetState Dec 29 18:46:53 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:46:53 darknight volumio[709]: info: Listing playlists Dec 29 18:46:53 darknight volumio[709]: info: Listing playlists Dec 29 18:47:00 darknight volumio[709]: Searching all installed plugins Dec 29 18:47:00 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:47:00 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: , search Dec 29 18:47:00 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 29 18:47:00 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Dec 29 18:47:00 darknight volumio[709]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Dec 29 18:47:02 darknight volumio[709]: Searching all installed plugins Dec 29 18:47:02 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:47:02 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: , search Dec 29 18:47:02 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 29 18:47:02 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Dec 29 18:47:02 darknight volumio[709]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Dec 29 18:47:03 darknight volumio[709]: info: CoreCommandRouter::volumioGetState Dec 29 18:47:03 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:47:04 darknight volumio[709]: Searching all installed plugins Dec 29 18:47:04 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 18:47:04 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: , search Dec 29 18:47:04 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 29 18:47:04 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Dec 29 18:47:04 darknight volumio[709]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Dec 29 18:47:04 darknight volumio[709]: info: All search sources collected, pushing search results Dec 29 18:47:04 darknight volumio[709]: info: All search sources collected, pushing search results Dec 29 18:47:06 darknight volumio[709]: info: All search sources collected, pushing search results Dec 29 18:47:08 darknight volumio[709]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 29 18:47:08 darknight volumio[709]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 29 18:47:09 darknight volumio[709]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jay%20Rock%2C%20Kendrick%20Lamar%2C%20Future%20%26%20James%20Blake/d31fc724-f24e-4ab7-ad28-5203c7c0d694.jpg' Dec 29 18:47:10 darknight volumio[709]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/James%20Arthur%2C%20Anne-Marie/113e3588-b50f-4060-a318-6aa9e6c2df9d.jpg' Dec 29 18:47:13 darknight volumio[709]: info: CoreCommandRouter::volumioGetState Dec 29 18:47:13 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:47:13 darknight volumio[709]: info: Listing playlists Dec 29 18:47:13 darknight volumio[709]: info: Listing playlists Dec 29 18:47:23 darknight volumio[709]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::ClearQueue Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::stop Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 18:47:23 darknight volumio[709]: info: CorePlayQueue::clearPlayQueue Dec 29 18:47:23 darknight volumio[709]: info: CorePlayQueue::saveQueue Dec 29 18:47:23 darknight volumio[709]: info: CoreCommandRouter::volumioPushQueue Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::addQueueItems Dec 29 18:47:23 darknight volumio[709]: info: CorePlayQueue::addQueueItems Dec 29 18:47:23 darknight volumio[709]: info: Preload queue cleared Dec 29 18:47:23 darknight volumio[709]: info: Adding Item to queue: music-library/NAS/MUSIC/BLOCK40/Various Artists - Funk Drive (2022)/64. Tower Of Power - Diggin On James Brown (Album Version).mp3 Dec 29 18:47:23 darknight volumio[709]: info: Exploding uri music-library/NAS/MUSIC/BLOCK40/Various Artists - Funk Drive (2022)/64. Tower Of Power - Diggin On James Brown (Album Version).mp3 in service mpd Dec 29 18:47:23 darknight volumio[709]: info: ALBUMART /albumart?cacheid=266&web=Tower%20Of%20Power/Funk%20Drive/extralarge&path=%2Fmnt%2FNAS%2FMUSIC%2FBLOCK40%2FVarious%20Artists%20-%20Funk%20Drive%20(2022)%2F64.%20Tower%20Of%20Power%20-%20Diggin%20On%20James%20Brown%20(Album%20Version).mp3&metadata=false Dec 29 18:47:23 darknight volumio[709]: info: URI /mnt/NAS/MUSIC/BLOCK40/Various Artists - Funk Drive (2022)/64. Tower Of Power - Diggin On James Brown (Album Version).mp3 Dec 29 18:47:23 darknight volumio[709]: info: CoreCommandRouter::volumioPushQueue Dec 29 18:47:23 darknight volumio[709]: info: CorePlayQueue::saveQueue Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::updateTrackBlock Dec 29 18:47:23 darknight volumio[709]: info: CorePlayQueue::getTrackBlock Dec 29 18:47:23 darknight volumio[709]: info: CoreCommandRouter::volumioPlay Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::play index 0 Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::stop Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::play index undefined Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 18:47:23 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::startPlaybackTimer Dec 29 18:47:23 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::clearAddPlayTracks NAS/MUSIC/BLOCK40/Various Artists - Funk Drive (2022)/64. Tower Of Power - Diggin On James Brown (Album Version).mp3 Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::sendMpdCommand stop Dec 29 18:47:23 darknight volumio[709]: info: sendMpdCommand stop took 12 milliseconds Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::sendMpdCommand clear Dec 29 18:47:23 darknight volumio[709]: info: Dec 29 18:47:23 darknight volumio[709]: ---------------------------- MPD announces system playlist update Dec 29 18:47:23 darknight volumio[709]: info: Ignoring MPD Status Update Dec 29 18:47:23 darknight volumio[709]: info: sendMpdCommand clear took 4 milliseconds Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::sendMpdCommand add "NAS/MUSIC/BLOCK40/Various Artists - Funk Drive (2022)/64. Tower Of Power - Diggin On James Brown (Album Version).mp3" Dec 29 18:47:23 darknight volumio[709]: error: updateQueue error: null Dec 29 18:47:23 darknight volumio[709]: info: Dec 29 18:47:23 darknight volumio[709]: ---------------------------- MPD announces system playlist update Dec 29 18:47:23 darknight volumio[709]: info: Ignoring MPD Status Update Dec 29 18:47:23 darknight volumio[709]: info: ------------------------------ 7ms Dec 29 18:47:23 darknight volumio[709]: info: sendMpdCommand add "NAS/MUSIC/BLOCK40/Various Artists - Funk Drive (2022)/64. Tower Of Power - Diggin On James Brown (Album Version).mp3" took 4 milliseconds Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::sendMpdCommand play Dec 29 18:47:23 darknight volumio[709]: info: ------------------------------ 8ms Dec 29 18:47:23 darknight volumio[709]: info: sendMpdCommand play took 6 milliseconds Dec 29 18:47:23 darknight volumio[709]: info: Dec 29 18:47:23 darknight volumio[709]: ---------------------------- MPD announces state update: player Dec 29 18:47:23 darknight volumio[709]: info: ControllerMpd::getState Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::sendMpdCommand status Dec 29 18:47:23 darknight volumio[709]: info: Dec 29 18:47:23 darknight volumio[709]: ---------------------------- MPD announces state update: player Dec 29 18:47:23 darknight volumio[709]: info: sendMpdCommand status took 37 milliseconds Dec 29 18:47:23 darknight volumio[709]: info: ControllerMpd::getState Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::sendMpdCommand status Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::parseState Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 18:47:23 darknight volumio[709]: info: sendMpdCommand status took 5 milliseconds Dec 29 18:47:23 darknight volumio[709]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::parseState Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::parseTrackInfo Dec 29 18:47:23 darknight volumio[709]: info: ControllerMpd::pushState Dec 29 18:47:23 darknight volumio[709]: info: CoreCommandRouter::servicePushState Dec 29 18:47:23 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:47:23 darknight volumio[709]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":278,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Diggin' On James Brown (Album Version)","artist":"Tower Of Power","album":"Funk Drive","uri":"NAS/MUSIC/BLOCK40/Various Artists - Funk Drive (2022)/64. Tower Of Power - Diggin On James Brown (Album Version).mp3","trackType":"mp3"} Dec 29 18:47:23 darknight volumio[709]: verbose: CURRENT POSITION 0 Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::syncState stateService play Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::syncState currentStatus stop Dec 29 18:47:23 darknight volumio[709]: info: ------------------------------ 63ms Dec 29 18:47:23 darknight volumio[709]: info: sendMpdCommand playlistinfo took 12 milliseconds Dec 29 18:47:23 darknight volumio[709]: verbose: ControllerMpd::parseTrackInfo Dec 29 18:47:23 darknight volumio[709]: info: ControllerMpd::pushState Dec 29 18:47:23 darknight volumio[709]: info: CoreCommandRouter::servicePushState Dec 29 18:47:23 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:47:23 darknight volumio[709]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":278,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Diggin' On James Brown (Album Version)","artist":"Tower Of Power","album":"Funk Drive","uri":"NAS/MUSIC/BLOCK40/Various Artists - Funk Drive (2022)/64. Tower Of Power - Diggin On James Brown (Album Version).mp3","trackType":"mp3"} Dec 29 18:47:23 darknight volumio[709]: verbose: CURRENT POSITION 0 Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::syncState stateService play Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::syncState currentStatus play Dec 29 18:47:23 darknight volumio[709]: info: Received an update from plugin. extracting info from payload Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::pushState Dec 29 18:47:23 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:47:23 darknight volumio[709]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 18:47:23 darknight volumio[709]: info: CoreCommandRouter::volumioPushState Dec 29 18:47:23 darknight volumio[709]: info: CoreStateMachine::pushState Dec 29 18:47:23 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:47:23 darknight volumio[709]: info: CoreCommandRouter::volumioPushState Dec 29 18:47:23 darknight volumio[709]: info: ------------------------------ 55ms Dec 29 18:47:23 darknight volumio[709]: info: CoreCommandRouter::volumioGetState Dec 29 18:47:23 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:47:31 darknight volumio[709]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Pete%20Rock%20feat.%20Leela%20James/21ece6f0-4092-444a-9b39-a105efc2dcda.jpg' Dec 29 18:47:33 darknight volumio[709]: info: CoreCommandRouter::volumioGetState Dec 29 18:47:33 darknight volumio[709]: info: CorePlayQueue::getTrack 0 Dec 29 18:47:33 darknight volumio[709]: info: Listing playlists Dec 29 18:47:33 darknight volumio[709]: info: Listing playlists Dec 29 18:47:35 darknight volumio[709]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/James%20Blake%20%26%20Bon%20Iver/45d1b634-30d2-4d3c-be3b-3cb9179170e7.jpg' Dec 29 18:47:37 darknight volumio[709]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 18:47:37 darknight volumio[709]: TypeError: Cannot read property 'slice' of null Dec 29 18:47:37 darknight volumio[709]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:714:41) Dec 29 18:47:37 darknight volumio[709]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:724:7) Dec 29 18:47:37 darknight volumio[709]: at Object.onceWrapper (events.js:422:26) Dec 29 18:47:37 darknight volumio[709]: at ClientRequest.emit (events.js:315:20) Dec 29 18:47:37 darknight volumio[709]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Dec 29 18:47:37 darknight volumio[709]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Dec 29 18:47:37 darknight volumio[709]: at TLSSocket.socketOnData (_http_client.js:509:22) Dec 29 18:47:37 darknight volumio[709]: at TLSSocket.emit (events.js:315:20) Dec 29 18:47:37 darknight volumio[709]: at addChunk (internal/streams/readable.js:309:12) Dec 29 18:47:37 darknight volumio[709]: at readableAddChunk (internal/streams/readable.js:284:9) Dec 29 18:47:37 darknight volumio[709]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 18:47:38 darknight sudo[1013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-29 18:46 Dec 29 18:47:38 darknight sudo[1013]: 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="c87c6e2b1ae33dc5801986cbcbe970898b92e7b4" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="b949d6001d7e656b4668f31c119d2247cdf45158" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 30 Mar 2023 05:45:03 PM CEST" VOLUMIO_VERSION="3.449" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6428d8e2c06e98483f5c5d77e8f01989"