Jan 09 19:02:01 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jan 09 19:02:01 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 09 19:02:01 volumio volumio[1381]: info: Received Get System Info
Jan 09 19:02:01 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 09 19:02:01 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 09 19:02:01 volumio volumio[1381]: info: Discovery: Getting this device information
Jan 09 19:02:01 volumio volumio[1381]: info: CoreCommandRouter::volumioGetState
Jan 09 19:02:01 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:02:01 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 09 19:02:02 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 09 19:02:02 volumio volumio[1381]: info: Received Get System Info
Jan 09 19:02:02 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 09 19:02:02 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 09 19:02:02 volumio volumio[1381]: info: Discovery: Getting this device information
Jan 09 19:02:02 volumio volumio[1381]: info: CoreCommandRouter::volumioGetState
Jan 09 19:02:02 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:02:02 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 09 19:02:09 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 09 19:02:09 volumio volumio[1381]: info: CoreCommandRouter::volumioGetQueue
Jan 09 19:02:09 volumio volumio[1381]: info: CoreStateMachine::getQueue
Jan 09 19:02:09 volumio volumio[1381]: info: CorePlayQueue::getQueue
Jan 09 19:02:18 volumio ntpd[1223]: PROTO: 194.0.5.123 unlink local addr 192.168.0.4 ->
Jan 09 19:02:18 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 09 19:02:18 volumio volumio[1381]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jan 09 19:02:18 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jan 09 19:02:18 volumio volumio[1381]: info: Received Get System Version
Jan 09 19:02:18 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 09 19:02:18 volumio volumio[1381]: info: Received Get System Info
Jan 09 19:02:18 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 09 19:02:18 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 09 19:02:18 volumio volumio[1381]: info: Discovery: Getting this device information
Jan 09 19:02:18 volumio volumio[1381]: info: CoreCommandRouter::volumioGetState
Jan 09 19:02:18 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:02:18 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 09 19:02:19 volumio ntpd[1223]: PROTO: 121.174.142.81 unlink local addr 192.168.0.4 ->
Jan 09 19:02:52 volumio volumio[1381]: info: VolumeController::SetAlsaVolume71
Jan 09 19:02:52 volumio volumio[1381]: info: CoreStateMachine::pushState
Jan 09 19:02:52 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:02:52 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:02:52 volumio volumio[1381]: info: CoreCommandRouter::volumioPushState
Jan 09 19:02:53 volumio volumio[1381]: info: VolumeController::SetAlsaVolume58
Jan 09 19:02:53 volumio volumio[1381]: info: CoreStateMachine::pushState
Jan 09 19:02:53 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:02:53 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:02:53 volumio volumio[1381]: info: CoreCommandRouter::volumioPushState
Jan 09 19:02:54 volumio volumio[1381]: info: VolumeController::SetAlsaVolume32
Jan 09 19:02:54 volumio volumio[1381]: info: CoreStateMachine::pushState
Jan 09 19:02:54 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:02:54 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:02:54 volumio volumio[1381]: info: CoreCommandRouter::volumioPushState
Jan 09 19:02:55 volumio volumio[1381]: info: VolumeController::SetAlsaVolume92
Jan 09 19:02:55 volumio volumio[1381]: info: CoreStateMachine::pushState
Jan 09 19:02:55 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:02:55 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:02:55 volumio volumio[1381]: info: CoreCommandRouter::volumioPushState
Jan 09 19:02:56 volumio volumio[1381]: info: VolumeController::SetAlsaVolume100
Jan 09 19:02:56 volumio volumio[1381]: info: CoreStateMachine::pushState
Jan 09 19:02:56 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:02:56 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:02:56 volumio volumio[1381]: info: CoreCommandRouter::volumioPushState
Jan 09 19:02:56 volumio volumio[1381]: info: VolumeController::SetAlsaVolume100
Jan 09 19:02:56 volumio volumio[1381]: info: CoreStateMachine::pushState
Jan 09 19:02:56 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:02:56 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 09 19:02:56 volumio volumio[1381]: info: CoreCommandRouter::volumioPushState
Jan 09 19:02:56 volumio volumio[1381]: info: VolumeController::SetAlsaVolume100
Jan 09 19:02:56 volumio volumio[1381]: info: CoreStateMachine::pushState
Jan 09 19:02:56 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:02:56 volumio volumio[1381]: info: CoreCommandRouter::volumioPushState
Jan 09 19:03:04 volumio volumio[1381]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13
Jan 09 19:03:04 volumio volumio[1381]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::volumioGetState
Jan 09 19:03:04 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 09 19:03:04 volumio volumio[1381]: info: Received Get System Info
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 09 19:03:04 volumio volumio[1381]: info: Discovery: Getting this device information
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::volumioGetState
Jan 09 19:03:04 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::volumioGetState
Jan 09 19:03:04 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:03:04 volumio volumio[1381]: info: Listing playlists
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 09 19:03:04 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jan 09 19:03:06 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jan 09 19:03:06 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 09 19:03:06 volumio volumio[1381]: info: Received Get System Info
Jan 09 19:03:06 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 09 19:03:06 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 09 19:03:06 volumio volumio[1381]: info: Discovery: Getting this device information
Jan 09 19:03:06 volumio volumio[1381]: info: CoreCommandRouter::volumioGetState
Jan 09 19:03:06 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:03:06 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 09 19:03:07 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jan 09 19:03:07 volumio volumio[1381]: info: Received Get System Info
Jan 09 19:03:07 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 09 19:03:07 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 09 19:03:07 volumio volumio[1381]: info: Discovery: Getting this device information
Jan 09 19:03:07 volumio volumio[1381]: info: CoreCommandRouter::volumioGetState
Jan 09 19:03:07 volumio volumio[1381]: info: CorePlayQueue::getTrack 0
Jan 09 19:03:07 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 09 19:03:10 volumio volumio[1381]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not access weather service: missing geographic coordinates.
Jan 09 19:03:10 volumio volumio[1381]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:95:19)
Jan 09 19:03:10 volumio volumio[1381]: at Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:116:37)
Jan 09 19:03:10 volumio volumio[1381]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:51:13
Jan 09 19:03:10 volumio volumio[1381]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5)
Jan 09 19:03:10 volumio volumio[1381]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:149:13)
Jan 09 19:03:10 volumio volumio[1381]: at Route.dispatch (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:119:3)
Jan 09 19:03:10 volumio volumio[1381]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5)
Jan 09 19:03:10 volumio volumio[1381]: at /data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:284:15
Jan 09 19:03:10 volumio volumio[1381]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:365:14)
Jan 09 19:03:10 volumio volumio[1381]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14)
Jan 09 19:03:10 volumio volumio[1381]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14)
Jan 09 19:03:10 volumio volumio[1381]: at Function.process_params (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:421:3)
Jan 09 19:03:10 volumio volumio[1381]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:280:10)
Jan 09 19:03:10 volumio volumio[1381]: at Function.handle (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:175:3)
Jan 09 19:03:10 volumio volumio[1381]: at router (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:47:12)
Jan 09 19:03:10 volumio volumio[1381]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5)
Jan 09 19:03:27 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 09 19:03:27 volumio volumio[1381]: info: CURURI: artists://
Jan 09 19:03:34 volumio volumio[1381]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 09 19:03:34 volumio volumio[1381]: info: CURURI: artists://Ada%20de%20Castro
Jan 09 19:03:44 volumio volumio[1381]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 09 19:03:44 volumio volumio[1381]: TypeError: Cannot read properties of null (reading 'slice')
Jan 09 19:03:44 volumio volumio[1381]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41)
Jan 09 19:03:44 volumio volumio[1381]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7)
Jan 09 19:03:44 volumio volumio[1381]: at Object.onceWrapper (node:events:629:26)
Jan 09 19:03:44 volumio volumio[1381]: at ClientRequest.emit (node:events:514:28)
Jan 09 19:03:44 volumio volumio[1381]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27)
Jan 09 19:03:44 volumio volumio[1381]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17)
Jan 09 19:03:44 volumio volumio[1381]: at TLSSocket.socketOnData (node:_http_client:535:22)
Jan 09 19:03:44 volumio volumio[1381]: at TLSSocket.emit (node:events:514:28)
Jan 09 19:03:44 volumio volumio[1381]: at addChunk (node:internal/streams/readable:343:12)
Jan 09 19:03:44 volumio volumio[1381]: at readableAddChunk (node:internal/streams/readable:316:9)
Jan 09 19:03:44 volumio volumio[1381]: at Readable.push (node:internal/streams/readable:253:10)
Jan 09 19:03:44 volumio volumio[1381]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23)
Jan 09 19:03:44 volumio volumio[1381]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 09 19:03:44 volumio sudo[4673]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-09 19:02'
Jan 09 19:03:44 volumio sudo[4673]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"