Dec 22 08:36:03 keuken go-librespot[1573]: time="2025-12-22T08:36:03+01:00" level=trace msg="received accesspoint ping"
Dec 22 08:36:03 keuken go-librespot[1573]: time="2025-12-22T08:36:03+01:00" level=trace msg="received accesspoint pong ack"
Dec 22 08:36:09 keuken kernel: hwmon hwmon1: Voltage normalised
Dec 22 08:36:09 keuken systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
Dec 22 08:36:09 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:36:10 keuken systemd[1]: setdatetime-helper.service: Deactivated successfully.
Dec 22 08:36:10 keuken systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Dec 22 08:36:10 keuken systemd[1]: setdatetime-helper.service: Consumed 1.037s CPU time.
Dec 22 08:36:11 keuken kernel: hwmon hwmon1: Undervoltage detected!
Dec 22 08:36:19 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:36:19 keuken volumio[1224]: info: Listing playlists
Dec 22 08:36:19 keuken volumio[1224]: info: Listing playlists
Dec 22 08:36:22 keuken go-librespot[1573]: time="2025-12-22T08:36:22+01:00" level=trace msg="sent dealer ping"
Dec 22 08:36:22 keuken go-librespot[1573]: time="2025-12-22T08:36:22+01:00" level=trace msg="received dealer pong"
Dec 22 08:36:29 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:36:29 keuken kernel: hwmon hwmon1: Voltage normalised
Dec 22 08:36:34 keuken kernel: hwmon hwmon1: Undervoltage detected!
Dec 22 08:36:38 keuken kernel: hwmon hwmon1: Voltage normalised
Dec 22 08:36:39 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:36:39 keuken volumio[1224]: info: Listing playlists
Dec 22 08:36:39 keuken volumio[1224]: info: Listing playlists
Dec 22 08:36:46 keuken kernel: hwmon hwmon1: Undervoltage detected!
Dec 22 08:36:49 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:36:52 keuken go-librespot[1573]: time="2025-12-22T08:36:52+01:00" level=trace msg="sent dealer ping"
Dec 22 08:36:52 keuken go-librespot[1573]: time="2025-12-22T08:36:52+01:00" level=trace msg="received dealer pong"
Dec 22 08:36:59 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:36:59 keuken volumio[1224]: info: Listing playlists
Dec 22 08:36:59 keuken volumio[1224]: info: Listing playlists
Dec 22 08:37:09 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:37:18 keuken volumio[1224]: verbose: New Socket.io Connection to 192.168.2.133:3000 from 192.168.2.156 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9
Dec 22 08:37:18 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 22 08:37:18 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 22 08:37:18 keuken volumio[1224]: info: Discovery: Getting this device information
Dec 22 08:37:18 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:37:18 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 22 08:37:19 keuken volumio[1224]: verbose: New Socket.io Connection to 192.168.2.133 from 192.168.2.156 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 10
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 22 08:37:19 keuken volumio[1224]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Dec 22 08:37:19 keuken volumio[1224]: info: Received Get System Info
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 22 08:37:19 keuken volumio[1224]: info: Discovery: Getting this device information
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:37:19 keuken volumio[1224]: info: Listing playlists
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::volumioGetQueue
Dec 22 08:37:19 keuken volumio[1224]: info: CoreStateMachine::getQueue
Dec 22 08:37:19 keuken volumio[1224]: info: CorePlayQueue::getQueue
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:37:19 keuken volumio[1224]: info: Listing playlists
Dec 22 08:37:19 keuken volumio[1224]: info: Listing playlists
Dec 22 08:37:19 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Dec 22 08:37:21 keuken volumio[1224]: info: Executing endpoint metavolumio
Dec 22 08:37:21 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 22 08:37:21 keuken volumio[1224]: info: Executing endpoint metavolumio
Dec 22 08:37:21 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 22 08:37:22 keuken go-librespot[1573]: time="2025-12-22T08:37:22+01:00" level=trace msg="sent dealer ping"
Dec 22 08:37:22 keuken go-librespot[1573]: time="2025-12-22T08:37:22+01:00" level=trace msg="received dealer pong"
Dec 22 08:37:23 keuken kernel: hwmon hwmon1: Voltage normalised
Dec 22 08:37:26 keuken kernel: hwmon hwmon1: Undervoltage detected!
Dec 22 08:37:29 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:37:29 keuken volumio[1224]: info: CoreCommandRouter::volumioGetState
Dec 22 08:37:31 keuken volumio[1224]: info: Executing endpoint metavolumio
Dec 22 08:37:31 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 22 08:37:31 keuken volumio[1224]: info: Executing endpoint metavolumio
Dec 22 08:37:31 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 22 08:37:37 keuken volumio[1224]: info: Preload queue cleared
Dec 22 08:37:37 keuken volumio[1224]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::ClearQueue
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::stop
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::stPlaybackTimer
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::updateTrackBlock
Dec 22 08:37:37 keuken volumio[1224]: info: CorePlayQueue::getTrackBlock
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::pushState
Dec 22 08:37:37 keuken volumio[1224]: info: CorePlayQueue::getTrack 0
Dec 22 08:37:37 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 22 08:37:37 keuken volumio[1224]: info: CoreCommandRouter::volumioPushState
Dec 22 08:37:37 keuken volumio[1224]: info: MRS: Pushing multiroomSync output update for this device
Dec 22 08:37:37 keuken volumio[1224]: info: MRS: Pushing multiroomSync output
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::serviceStop
Dec 22 08:37:37 keuken volumio[1224]: info: CorePlayQueue::getTrack 0
Dec 22 08:37:37 keuken volumio[1224]: info: CoreCommandRouter::serviceStop
Dec 22 08:37:37 keuken volumio[1224]: info: [1766389057177] ControllerWebradio::stop
Dec 22 08:37:37 keuken volumio[1224]: verbose: ControllerMpd::sendMpdCommand stop
Dec 22 08:37:37 keuken volumio[1224]: info: CorePlayQueue::clearPlayQueue
Dec 22 08:37:37 keuken volumio[1224]: info: CorePlayQueue::saveQueue
Dec 22 08:37:37 keuken volumio[1224]: info: CoreCommandRouter::volumioPushQueue
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::addQueueItems
Dec 22 08:37:37 keuken volumio[1224]: info: CorePlayQueue::addQueueItems
Dec 22 08:37:37 keuken volumio[1224]: info: Preload queue cleared
Dec 22 08:37:37 keuken volumio[1224]: info: Adding Item to queue: https://icecast.radiofrance.fr/fip-hifi.aac?id=radiofrance
Dec 22 08:37:37 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Dec 22 08:37:37 keuken volumio[1224]: info: CoreCommandRouter::volumioPushQueue
Dec 22 08:37:37 keuken volumio[1224]: info: CorePlayQueue::saveQueue
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::updateTrackBlock
Dec 22 08:37:37 keuken volumio[1224]: info: CorePlayQueue::getTrackBlock
Dec 22 08:37:37 keuken volumio[1224]: info: CoreCommandRouter::volumioPlay
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::play index 0
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::stop
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::play index undefined
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 22 08:37:37 keuken volumio[1224]: info: CorePlayQueue::getTrack 0
Dec 22 08:37:37 keuken volumio[1224]: info: CoreStateMachine::startPlaybackTimer
Dec 22 08:37:37 keuken volumio[1224]: info: CorePlayQueue::getTrack 0
Dec 22 08:37:37 keuken volumio[1224]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 22 08:37:37 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 22 08:37:37 keuken volumio[1224]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Dec 22 08:37:37 keuken volumio[1224]: info: [1766389057197] ControllerWebradio::clearAddPlayTrack
Dec 22 08:37:37 keuken volumio[1224]: verbose: ControllerMpd::sendMpdCommand stop
Dec 22 08:37:37 keuken volumio[1224]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30
Dec 22 08:37:37 keuken volumio[1224]: SPOTIFY: SPOTIFY VOLUME 31
Dec 22 08:37:37 keuken volumio[1224]: SPOTIFY: VOLUMIO VOLUME 30
Dec 22 08:37:37 keuken volumio[1224]: SPOTIFY: DELTA VOLUME ENOUGH: false
Dec 22 08:37:37 keuken volumio[1224]: info: ControllerMpd::getState
Dec 22 08:37:37 keuken volumio[1224]: verbose: ControllerMpd::sendMpdCommand status
Dec 22 08:37:37 keuken volumio[1224]: info:
Dec 22 08:37:37 keuken volumio[1224]: ---------------------------- MPD announces state update: player
Dec 22 08:37:37 keuken volumio[1224]: info: sendMpdCommand stop took 39 milliseconds
Dec 22 08:37:37 keuken volumio[1224]: info: ControllerMpd::getState
Dec 22 08:37:37 keuken volumio[1224]: verbose: ControllerMpd::sendMpdCommand status
Dec 22 08:37:37 keuken volumio[1224]: info: sendMpdCommand stop took 20 milliseconds
Dec 22 08:37:37 keuken volumio[1224]: verbose: ControllerMpd::sendMpdCommand clear
Dec 22 08:37:37 keuken volumio[1224]: info:
Dec 22 08:37:37 keuken volumio[1224]: ---------------------------- MPD announces system playlist update
Dec 22 08:37:37 keuken volumio[1224]: info: Ignoring MPD Status Update
Dec 22 08:37:37 keuken volumio[1224]: info: sendMpdCommand status took 8 milliseconds
Dec 22 08:37:37 keuken volumio[1224]: info: sendMpdCommand status took 7 milliseconds
Dec 22 08:37:37 keuken volumio[1224]: info: sendMpdCommand clear took 6 milliseconds
Dec 22 08:37:37 keuken volumio[1224]: verbose: ControllerMpd::parseState
Dec 22 08:37:37 keuken volumio[1224]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 22 08:37:37 keuken volumio[1224]: verbose: ControllerMpd::parseState
Dec 22 08:37:37 keuken volumio[1224]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 22 08:37:37 keuken volumio[1224]: verbose: ControllerMpd::sendMpdCommand load "https://icecast.radiofrance.fr/fip-hifi.aac?id=radiofrance"
Dec 22 08:37:37 keuken volumio[1224]: error: updateQueue error: null
Dec 22 08:37:37 keuken volumio[1224]: info: ------------------------------ 4ms
Dec 22 08:37:37 keuken volumio[1224]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 22 08:37:37 keuken volumio[1224]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 22 08:37:37 keuken volumio[1224]: verbose: ControllerMpd::parseTrackInfo
Dec 22 08:37:37 keuken volumio[1224]: verbose: ControllerMpd::parseTrackInfo
Dec 22 08:37:37 keuken volumio[1224]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Dec 22 08:37:37 keuken volumio[1224]: info: ------------------------------ 13ms
Dec 22 08:37:37 keuken volumio[1224]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 22 08:37:37 keuken volumio[1224]: TypeError: Cannot read properties of undefined (reading 'split')
Dec 22 08:37:37 keuken volumio[1224]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:280:60)
Dec 22 08:37:37 keuken volumio[1224]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Dec 22 08:37:37 keuken volumio[1224]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11)
Dec 22 08:37:37 keuken volumio[1224]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 22 08:37:38 keuken sudo[1156]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-22 08:36'
Dec 22 08:37:38 keuken sudo[1156]: 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"