Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 11 20:13:27 volumio volumio[3485]: info: Getting Alsa Cards List without I2S DAC
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 20:13:27 volumio volumio[3485]: Invalid card number '2'.
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Apr 11 20:13:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 11 20:14:12 volumio volumio[3485]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object]
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::volumioGetState
Apr 11 20:14:12 volumio volumio[3485]: info: CorePlayQueue::getTrack 0
Apr 11 20:14:12 volumio volumio[3485]: info: Restoring Previous Volume level: 100 false false
Apr 11 20:14:12 volumio volumio[3485]: info: Output device has changed, restarting MPD
Apr 11 20:14:12 volumio volumio[3485]: info: Output device has changed, restarting Shairport Sync
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 20:14:12 volumio sudo[5673]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 11 20:14:12 volumio sudo[5673]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 20:14:12 volumio sudo[5671]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 11 20:14:12 volumio sudo[5671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 20:14:12 volumio volumio[3485]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 11 20:14:12 volumio volumio[3485]: info: Volume configurations have been set
Apr 11 20:14:12 volumio sudo[5671]: pam_unix(sudo:session): session closed for user root
Apr 11 20:14:12 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Apr 11 20:14:12 volumio volumio[3485]: info: Updating Volume Controller Parameters: Device: 2 Name: Audiophonics I-Sabre ES9028Q2M Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Apr 11 20:14:12 volumio volumio[3485]: info: Disabling external Volume Control
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 20:14:12 volumio volumio[3485]: info: CoreStateMachine::pushState
Apr 11 20:14:12 volumio volumio[3485]: info: CorePlayQueue::getTrack 0
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::volumioPushState
Apr 11 20:14:12 volumio volumio[3485]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false
Apr 11 20:14:12 volumio volumio[3485]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false
Apr 11 20:14:12 volumio volumio[3485]: info: FusionDsp - Volumio is not playing
Apr 11 20:14:12 volumio volumio[3485]: info: FusionDsp - Clipped samples monitor stopped
Apr 11 20:14:12 volumio volumio[3485]: info: PeppySpectrum ---peppyspectrum status stop
Apr 11 20:14:12 volumio volumio[3485]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number '2'.
Apr 11 20:14:12 volumio volumio[3485]: info: MPD Permissions set
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 20:14:12 volumio sudo[5685]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Apr 11 20:14:12 volumio sudo[5685]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 20:14:12 volumio systemd[1]: mpd.service: Deactivated successfully.
Apr 11 20:14:12 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Apr 11 20:14:12 volumio systemd[1]: mpd.socket: Deactivated successfully.
Apr 11 20:14:12 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Apr 11 20:14:12 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 11 20:14:12 volumio volumio[3485]: info: Getting Alsa Cards List without I2S DAC
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber
Apr 11 20:14:12 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 20:14:12 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Apr 11 20:14:12 volumio volumio[3485]: Invalid card number '2'.
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Apr 11 20:14:12 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 11 20:14:12 volumio volumio[3485]: info: Starting Shairport Sync
Apr 11 20:14:12 volumio sudo[5685]: pam_unix(sudo:session): session closed for user root
Apr 11 20:14:12 volumio sudo[5711]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 11 20:14:12 volumio volumio[3485]: info: peppyspectrum Daemon Stop
Apr 11 20:14:12 volumio sudo[5711]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 20:14:12 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Apr 11 20:14:12 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Apr 11 20:14:12 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Apr 11 20:14:12 volumio systemd[1]: shairport-sync.service: Consumed 1.696s CPU time.
Apr 11 20:14:12 volumio sudo[5700]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 11 20:14:12 volumio sudo[5700]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 11 20:14:12 volumio sudo[5700]: pam_unix(sudo:session): session closed for user root
Apr 11 20:14:13 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Apr 11 20:14:13 volumio sudo[5711]: pam_unix(sudo:session): session closed for user root
Apr 11 20:14:13 volumio volumio[3485]: info: Shairport-Sync Started
Apr 11 20:14:13 volumio mpd[5715]: 2026-04-11T20:14:13 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 11 20:14:13 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Apr 11 20:14:13 volumio sudo[5673]: pam_unix(sudo:session): session closed for user root
Apr 11 20:14:13 volumio volumio[3485]: error: updateQueue error: null
Apr 11 20:14:17 volumio volumio[3485]: info: VolumeController::SetAlsaVolume100
Apr 11 20:14:17 volumio volumio[3485]: info: CoreStateMachine::pushState
Apr 11 20:14:17 volumio volumio[3485]: info: CorePlayQueue::getTrack 0
Apr 11 20:14:17 volumio volumio[3485]: info: CoreCommandRouter::volumioPushState
Apr 11 20:14:17 volumio volumio[3485]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false
Apr 11 20:14:17 volumio volumio[3485]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false
Apr 11 20:14:17 volumio volumio[3485]: info: FusionDsp - Volumio is not playing
Apr 11 20:14:17 volumio volumio[3485]: info: FusionDsp - Clipped samples monitor stopped
Apr 11 20:14:17 volumio volumio[3485]: info: PeppySpectrum ---peppyspectrum status stop
Apr 11 20:14:17 volumio sudo[5750]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service
Apr 11 20:14:17 volumio sudo[5750]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 20:14:17 volumio sudo[5750]: pam_unix(sudo:session): session closed for user root
Apr 11 20:14:17 volumio volumio[3485]: info: peppyspectrum Daemon Stop
Apr 11 20:14:27 volumio volumio[3485]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 20:14:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 11 20:14:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 11 20:14:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 11 20:14:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Apr 11 20:14:27 volumio volumio[3485]: info: Received Get System Version
Apr 11 20:14:27 volumio volumio[3485]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 11 20:14:45 volumio volumio[3485]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 20:14:46 volumio volumio[3485]: TypeError: Cannot read properties of undefined (reading 'plugin_type')
Apr 11 20:14:46 volumio volumio[3485]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1644:56)
Apr 11 20:14:46 volumio volumio[3485]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1540:29)
Apr 11 20:14:46 volumio volumio[3485]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1353:45)
Apr 11 20:14:46 volumio volumio[3485]: at Socket.emit (node:events:514:28)
Apr 11 20:14:46 volumio volumio[3485]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Apr 11 20:14:46 volumio volumio[3485]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11)
Apr 11 20:14:46 volumio volumio[3485]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 20:14:46 volumio sudo[5842]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-11 20:13'
Apr 11 20:14:46 volumio sudo[5842]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"