-- Logs begin at Mon 2026-01-12 18:55:43 GMT, end at Mon 2026-01-12 21:25:02 GMT. -- Jan 12 21:24:09 volumio5784 volumio[7517]: info: Preload queue cleared Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreCommandRouter::volumioPause Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::pause Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::stPlaybackTimer Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::servicePause Jan 12 21:24:21 volumio5784 volumio[7517]: info: CorePlayQueue::getTrack 21 Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreCommandRouter::servicePause Jan 12 21:24:21 volumio5784 volumio[7517]: info: [1768253061613] ControllerUPNPBrowser::pause Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::sendMpdCommand pause Jan 12 21:24:21 volumio5784 volumio[7517]: info: sendMpdCommand pause took 1 milliseconds Jan 12 21:24:21 volumio5784 volumio[7517]: info: Jan 12 21:24:21 volumio5784 volumio[7517]: ---------------------------- MPD announces state update: player Jan 12 21:24:21 volumio5784 volumio[7517]: info: ControllerMpd::getState Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::sendMpdCommand status Jan 12 21:24:21 volumio5784 volumio[7517]: info: Jan 12 21:24:21 volumio5784 volumio[7517]: ---------------------------- MPD announces state update: player Jan 12 21:24:21 volumio5784 volumio[7517]: info: ControllerMpd::getState Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::sendMpdCommand status Jan 12 21:24:21 volumio5784 volumio[7517]: info: Jan 12 21:24:21 volumio5784 volumio[7517]: ---------------------------- MPD announces state update: player Jan 12 21:24:21 volumio5784 volumio[7517]: info: ControllerMpd::getState Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::sendMpdCommand status Jan 12 21:24:21 volumio5784 volumio[7517]: info: sendMpdCommand status took 3 milliseconds Jan 12 21:24:21 volumio5784 volumio[7517]: info: sendMpdCommand status took 3 milliseconds Jan 12 21:24:21 volumio5784 volumio[7517]: info: sendMpdCommand status took 2 milliseconds Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::parseState Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::parseState Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::parseState Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 21:24:21 volumio5784 volumio[7517]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 12 21:24:21 volumio5784 volumio[7517]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 12 21:24:21 volumio5784 volumio[7517]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::parseTrackInfo Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::parseTrackInfo Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: ControllerMpd::parseTrackInfo Jan 12 21:24:21 volumio5784 volumio[7517]: info: ControllerMpd::pushState Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreCommandRouter::servicePushState Jan 12 21:24:21 volumio5784 volumio[7517]: info: CorePlayQueue::getTrack 21 Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":20088,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"b37ad5158d9ed6aac2873453fb3d8fc8.wav?profile_id=0&convert=wav","artist":null,"album":null,"uri":"http://192.168.0.102:56923/content/b37ad5158d9ed6aac2873453fb3d8fc8.wav?profile_id=0&convert=wav","trackType":""} Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: CURRENT POSITION 21 Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::syncState stateService pause Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::syncState currentStatus pause Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::pushState Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreCommandRouter::volumioPushState Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::stPlaybackTimer Jan 12 21:24:21 volumio5784 volumio[7517]: info: ControllerMpd::pushState Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreCommandRouter::servicePushState Jan 12 21:24:21 volumio5784 volumio[7517]: info: CorePlayQueue::getTrack 21 Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":20088,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"b37ad5158d9ed6aac2873453fb3d8fc8.wav?profile_id=0&convert=wav","artist":null,"album":null,"uri":"http://192.168.0.102:56923/content/b37ad5158d9ed6aac2873453fb3d8fc8.wav?profile_id=0&convert=wav","trackType":""} Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: CURRENT POSITION 21 Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::syncState stateService pause Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::syncState currentStatus pause Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::pushState Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreCommandRouter::volumioPushState Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::stPlaybackTimer Jan 12 21:24:21 volumio5784 volumio[7517]: info: ControllerMpd::pushState Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreCommandRouter::servicePushState Jan 12 21:24:21 volumio5784 volumio[7517]: info: CorePlayQueue::getTrack 21 Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":20088,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"b37ad5158d9ed6aac2873453fb3d8fc8.wav?profile_id=0&convert=wav","artist":null,"album":null,"uri":"http://192.168.0.102:56923/content/b37ad5158d9ed6aac2873453fb3d8fc8.wav?profile_id=0&convert=wav","trackType":""} Jan 12 21:24:21 volumio5784 volumio[7517]: verbose: CURRENT POSITION 21 Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::syncState stateService pause Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::syncState currentStatus pause Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::pushState Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreCommandRouter::volumioPushState Jan 12 21:24:21 volumio5784 volumio[7517]: info: CoreStateMachine::stPlaybackTimer Jan 12 21:24:21 volumio5784 volumio[7517]: info: ------------------------------ 38ms Jan 12 21:24:21 volumio5784 volumio[7517]: info: ------------------------------ 38ms Jan 12 21:24:21 volumio5784 volumio[7517]: info: ------------------------------ 36ms Jan 12 21:24:41 volumio5784 volumio[7517]: verbose: New Socket.io Connection to 192.168.0.107 from 192.168.0.102 UA: Mozilla/5.0 (X11; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0 Engine version: 3 Transport: polling Total Clients: 5 Jan 12 21:24:42 volumio5784 volumio[7517]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 12 21:24:43 volumio5784 volumio[7517]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreCommandRouter::volumioGetState Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreCommandRouter::volumioGetState Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 21:24:44 volumio5784 volumio[7517]: info: Received Get System Info Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 21:24:44 volumio5784 volumio[7517]: info: Discovery: Getting this device information Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreCommandRouter::volumioGetState Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreCommandRouter::volumioGetState Jan 12 21:24:44 volumio5784 volumio[7517]: info: Listing playlists Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreCommandRouter::volumioGetQueue Jan 12 21:24:44 volumio5784 volumio[7517]: info: CoreStateMachine::getQueue Jan 12 21:24:44 volumio5784 volumio[7517]: info: CorePlayQueue::getQueue Jan 12 21:25:01 volumio5784 volumio[7517]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 21:25:01 volumio5784 volumio[7517]: TypeError: Cannot read property 'slice' of null Jan 12 21:25:01 volumio5784 volumio[7517]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Jan 12 21:25:01 volumio5784 volumio[7517]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Jan 12 21:25:01 volumio5784 volumio[7517]: at Object.onceWrapper (events.js:422:26) Jan 12 21:25:01 volumio5784 volumio[7517]: at ClientRequest.emit (events.js:315:20) Jan 12 21:25:01 volumio5784 volumio[7517]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Jan 12 21:25:01 volumio5784 volumio[7517]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Jan 12 21:25:01 volumio5784 volumio[7517]: at TLSSocket.socketOnData (_http_client.js:509:22) Jan 12 21:25:01 volumio5784 volumio[7517]: at TLSSocket.emit (events.js:315:20) Jan 12 21:25:01 volumio5784 volumio[7517]: at addChunk (internal/streams/readable.js:309:12) Jan 12 21:25:01 volumio5784 volumio[7517]: at readableAddChunk (internal/streams/readable.js:284:9) Jan 12 21:25:01 volumio5784 volumio[7517]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Jan 12 21:25:01 volumio5784 volumio[7517]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Jan 12 21:25:01 volumio5784 volumio[7517]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 21:25:02 volumio5784 sudo[20886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-12 21:24 Jan 12 21:25:02 volumio5784 sudo[20886]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"