-- Logs begin at Thu 2019-02-14 19:11:59 JST, end at Sun 2026-08-30 19:00:35 JST. -- Aug 30 18:59:01 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 18:59:05 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 18:59:06 volumio go-librespot[11610]: time="2026-08-30T18:59:06+09:00" level=trace msg="sent dealer ping" Aug 30 18:59:06 volumio go-librespot[11610]: time="2026-08-30T18:59:06+09:00" level=trace msg="received dealer pong" Aug 30 18:59:07 volumio volumio[1056]: info: CALLMETHOD: miscellanea albumart saveAlbumartOptions [object Object] Aug 30 18:59:07 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: albumart , saveAlbumartOptions Aug 30 18:59:09 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 18:59:13 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 18:59:17 volumio volumio[1056]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 18:59:17 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 18:59:17 volumio volumio[1056]: info: CoreCommandRouter::volumioGetQueue Aug 30 18:59:17 volumio volumio[1056]: info: CoreStateMachine::getQueue Aug 30 18:59:17 volumio volumio[1056]: info: CorePlayQueue::getQueue Aug 30 18:59:19 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 30 18:59:19 volumio volumio[1056]: info: CURURI: artists:// Aug 30 18:59:19 volumio volumio[1056]: info: Preload queue cleared Aug 30 18:59:36 volumio go-librespot[11610]: time="2026-08-30T18:59:36+09:00" level=trace msg="sent dealer ping" Aug 30 18:59:36 volumio go-librespot[11610]: time="2026-08-30T18:59:36+09:00" level=trace msg="received dealer pong" Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 18:59:38 volumio volumio[1056]: info: Retrieving Cloud Streaming UI Aug 30 18:59:38 volumio volumio[1056]: info: Getting Tidal Cloud Configuration Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 18:59:38 volumio volumio[1056]: info: Getting Qobuz Cloud Configuration Aug 30 18:59:38 volumio volumio[1056]: info: Asking plugin for UI Config Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 18:59:38 volumio volumio[1056]: info: Getting Spotify Cloud Configuration Aug 30 18:59:38 volumio volumio[1056]: info: Asking plugin for UI Config Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 18:59:38 volumio volumio[1056]: info: Saving Spotify Acccount Aug 30 18:59:38 volumio volumio[1056]: info: Got Tidal Cloud Configuration Aug 30 18:59:38 volumio volumio[1056]: info: Got it Aug 30 18:59:38 volumio volumio[1056]: info: Got it Aug 30 18:59:38 volumio volumio[1056]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 18:59:38 volumio volumio[1056]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::volumioGetBrowseSources Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::volumioGetBrowseSources Aug 30 18:59:38 volumio volumio[1056]: info: CoreCommandRouter::volumioGetBrowseSources Aug 30 18:59:39 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 18:59:39 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 30 18:59:43 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 18:59:50 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 18:59:51 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 18:59:52 volumio volumio[1056]: info: CALLMETHOD: miscellanea albumart saveAlbumartOptions [object Object] Aug 30 18:59:52 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: albumart , saveAlbumartOptions Aug 30 18:59:55 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 19:00:03 volumio volumio-remote-updater[597]: [2026-08-30 19:00:03] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Aug 30 19:00:06 volumio go-librespot[11610]: time="2026-08-30T19:00:06+09:00" level=trace msg="sent dealer ping" Aug 30 19:00:06 volumio go-librespot[11610]: time="2026-08-30T19:00:06+09:00" level=trace msg="received dealer pong" Aug 30 19:00:07 volumio volumio5-onboarding[1183]: time=2026-08-30T19:00:07.257+09:00 level=ERROR msg="failed reading message" error="websocket: close 1000 (normal)" Aug 30 19:00:08 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 19:00:08 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 19:00:08 volumio volumio-remote-updater[597]: [2026-08-30 19:00:08] [connect] Successful connection Aug 30 19:00:08 volumio volumio[1056]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 6 Aug 30 19:00:08 volumio volumio-remote-updater[597]: [2026-08-30 19:00:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1788084008 101 Aug 30 19:00:10 volumio volumio[1056]: info: CALLMETHOD: miscellanea my_music updateMusicLibrarySupersearchSources [object Object] Aug 30 19:00:10 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: my_music , updateMusicLibrarySupersearchSources Aug 30 19:00:11 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 19:00:11 volumio volumio[1056]: info: CoreCommandRouter::volumioGetBrowseSources Aug 30 19:00:11 volumio volumio[1056]: info: CoreCommandRouter::volumioGetBrowseSources Aug 30 19:00:11 volumio volumio[1056]: info: CoreCommandRouter::updateGlobalSearchableBrowseSources Aug 30 19:00:15 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 30 19:00:27 volumio volumio[1056]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 19:00:27 volumio volumio[1056]: TypeError: Cannot read property 'slice' of null Aug 30 19:00:27 volumio volumio[1056]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Aug 30 19:00:27 volumio volumio[1056]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Aug 30 19:00:27 volumio volumio[1056]: at Object.onceWrapper (events.js:422:26) Aug 30 19:00:27 volumio volumio[1056]: at ClientRequest.emit (events.js:315:20) Aug 30 19:00:27 volumio volumio[1056]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Aug 30 19:00:27 volumio volumio[1056]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Aug 30 19:00:27 volumio volumio[1056]: at HTTPParser.execute () Aug 30 19:00:27 volumio volumio[1056]: at TLSSocket.socketOnData (_http_client.js:509:22) Aug 30 19:00:27 volumio volumio[1056]: at TLSSocket.emit (events.js:315:20) Aug 30 19:00:27 volumio volumio[1056]: at addChunk (internal/streams/readable.js:309:12) Aug 30 19:00:27 volumio volumio[1056]: at readableAddChunk (internal/streams/readable.js:284:9) Aug 30 19:00:27 volumio volumio[1056]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Aug 30 19:00:27 volumio volumio[1056]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Aug 30 19:00:27 volumio volumio[1056]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 19:00:35 volumio sudo[17129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-30 18:59 Aug 30 19:00:35 volumio sudo[17129]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"