Oct 16 09:04:04 pi4test sshd[2177]: Accepted publickey for volumio from 192.168.30.10 port 37302 ssh2: RSA SHA256:sWbjE//P/1DZ7B1rDIsILI6jb/aFSwbMBkOgjWJbRNU Oct 16 09:04:04 pi4test sshd[2177]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Oct 16 09:04:04 pi4test systemd-logind[719]: New session 4 of user volumio. Oct 16 09:04:04 pi4test systemd[1]: Started session-4.scope - Session 4 of User volumio. Oct 16 09:04:04 pi4test sshd[2177]: pam_env(sshd:session): deprecated reading of user environment enabled Oct 16 09:04:07 pi4test sshd[2188]: Received disconnect from 192.168.30.10 port 37302:11: disconnected by user Oct 16 09:04:07 pi4test sshd[2188]: Disconnected from user volumio 192.168.30.10 port 37302 Oct 16 09:04:07 pi4test sshd[2177]: pam_unix(sshd:session): session closed for user volumio Oct 16 09:04:07 pi4test systemd[1]: session-4.scope: Deactivated successfully. Oct 16 09:04:07 pi4test systemd[1]: session-4.scope: Consumed 6.545s CPU time. Oct 16 09:04:07 pi4test systemd-logind[719]: Session 4 logged out. Waiting for processes to exit. Oct 16 09:04:07 pi4test systemd-logind[719]: Removed session 4. Oct 16 09:04:41 pi4test sshd[2280]: Connection closed by authenticating user volumio 192.168.30.10 port 51236 [preauth] Oct 16 09:04:43 pi4test sshd[2282]: Connection closed by authenticating user volumio 192.168.30.10 port 51240 [preauth] Oct 16 09:04:44 pi4test sshd[2284]: Accepted publickey for volumio from 192.168.30.10 port 51244 ssh2: RSA SHA256:sWbjE//P/1DZ7B1rDIsILI6jb/aFSwbMBkOgjWJbRNU Oct 16 09:04:44 pi4test sshd[2284]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Oct 16 09:04:44 pi4test systemd-logind[719]: New session 5 of user volumio. Oct 16 09:04:44 pi4test systemd[1]: Started session-5.scope - Session 5 of User volumio. Oct 16 09:04:44 pi4test sshd[2284]: pam_env(sshd:session): deprecated reading of user environment enabled Oct 16 09:04:44 pi4test sshd[2295]: Received disconnect from 192.168.30.10 port 51244:11: disconnected by user Oct 16 09:04:44 pi4test sshd[2295]: Disconnected from user volumio 192.168.30.10 port 51244 Oct 16 09:04:44 pi4test sshd[2284]: pam_unix(sshd:session): session closed for user volumio Oct 16 09:04:44 pi4test systemd[1]: session-5.scope: Deactivated successfully. Oct 16 09:04:44 pi4test systemd-logind[719]: Session 5 logged out. Waiting for processes to exit. Oct 16 09:04:44 pi4test systemd-logind[719]: Removed session 5. Oct 16 09:04:45 pi4test sshd[2297]: Connection closed by authenticating user volumio 192.168.30.10 port 60276 [preauth] Oct 16 09:04:47 pi4test sshd[2299]: Accepted publickey for volumio from 192.168.30.10 port 60278 ssh2: RSA SHA256:sWbjE//P/1DZ7B1rDIsILI6jb/aFSwbMBkOgjWJbRNU Oct 16 09:04:47 pi4test sshd[2299]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Oct 16 09:04:47 pi4test systemd-logind[719]: New session 6 of user volumio. Oct 16 09:04:47 pi4test systemd[1]: Started session-6.scope - Session 6 of User volumio. Oct 16 09:04:47 pi4test sshd[2299]: pam_env(sshd:session): deprecated reading of user environment enabled Oct 16 09:04:47 pi4test sshd[2310]: Received disconnect from 192.168.30.10 port 60278:11: disconnected by user Oct 16 09:04:47 pi4test sshd[2310]: Disconnected from user volumio 192.168.30.10 port 60278 Oct 16 09:04:47 pi4test sshd[2299]: pam_unix(sshd:session): session closed for user volumio Oct 16 09:04:47 pi4test systemd[1]: session-6.scope: Deactivated successfully. Oct 16 09:04:47 pi4test systemd-logind[719]: Session 6 logged out. Waiting for processes to exit. Oct 16 09:04:47 pi4test systemd-logind[719]: Removed session 6. Oct 16 09:04:48 pi4test sshd[2316]: Accepted publickey for volumio from 192.168.30.10 port 60292 ssh2: RSA SHA256:sWbjE//P/1DZ7B1rDIsILI6jb/aFSwbMBkOgjWJbRNU Oct 16 09:04:48 pi4test sshd[2316]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Oct 16 09:04:48 pi4test systemd-logind[719]: New session 7 of user volumio. Oct 16 09:04:48 pi4test systemd[1]: Started session-7.scope - Session 7 of User volumio. Oct 16 09:04:48 pi4test sshd[2316]: pam_env(sshd:session): deprecated reading of user environment enabled Oct 16 09:04:51 pi4test sudo[2350]: volumio : PWD=/volumio ; USER=root ; COMMAND=/bin/systemctl disable lcd1602-vumeter.service Oct 16 09:04:51 pi4test sudo[2350]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 09:04:51 pi4test systemd[1]: Reloading. Oct 16 09:04:51 pi4test sudo[2350]: pam_unix(sudo:session): session closed for user root Oct 16 09:04:52 pi4test sshd[2341]: Received disconnect from 192.168.30.10 port 60292:11: disconnected by user Oct 16 09:04:52 pi4test sshd[2341]: Disconnected from user volumio 192.168.30.10 port 60292 Oct 16 09:04:52 pi4test sshd[2316]: pam_unix(sshd:session): session closed for user volumio Oct 16 09:04:52 pi4test systemd[1]: session-7.scope: Deactivated successfully. Oct 16 09:04:52 pi4test systemd-logind[719]: Session 7 logged out. Waiting for processes to exit. Oct 16 09:04:52 pi4test systemd-logind[719]: Removed session 7. Oct 16 09:05:04 pi4test sudo[2386]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop lcd1602-vumeter.service Oct 16 09:05:04 pi4test sudo[2386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 09:05:04 pi4test systemd[1]: Stopping lcd1602-vumeter.service - LCD1602 VU meter display... Oct 16 09:05:04 pi4test run.sh[692]: lcd1602-vumeter: leaving: the glass is cleared Oct 16 09:05:04 pi4test systemd[1]: lcd1602-vumeter.service: Deactivated successfully. Oct 16 09:05:04 pi4test systemd[1]: Stopped lcd1602-vumeter.service - LCD1602 VU meter display. Oct 16 09:05:05 pi4test sudo[2386]: pam_unix(sudo:session): session closed for user root Oct 16 09:05:05 pi4test volumio[1197]: info: Disabling plugin lcd1602_vumeter Oct 16 09:05:05 pi4test volumio[1197]: info: Preparing to generate the ALSA configuration file Oct 16 09:05:05 pi4test volumio[1197]: info: Asound.conf file written Oct 16 09:05:05 pi4test sudo[2391]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 16 09:05:05 pi4test sudo[2391]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 09:05:05 pi4test sudo[2391]: pam_unix(sudo:session): session closed for user root Oct 16 09:05:05 pi4test volumio[1197]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 16 09:05:05 pi4test volumio[1197]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Oct 16 09:05:05 pi4test volumio[1197]: info: Output device has changed, restarting MPD Oct 16 09:05:05 pi4test sudo[2397]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 09:05:05 pi4test sudo[2397]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 09:05:05 pi4test volumio[1197]: info: Output device has changed, restarting Shairport Sync Oct 16 09:05:05 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 09:05:05 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 09:05:05 pi4test sudo[2399]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 09:05:05 pi4test sudo[2399]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 09:05:05 pi4test sudo[2397]: pam_unix(sudo:session): session closed for user root Oct 16 09:05:05 pi4test volumio[1197]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 09:05:05 pi4test volumio[1197]: info: Done. Oct 16 09:05:05 pi4test volumio[1197]: info: MPD Permissions set Oct 16 09:05:05 pi4test systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 16 09:05:05 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 09:05:05 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 09:05:05 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 09:05:05 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 09:05:05 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 09:05:05 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 09:05:05 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 09:05:05 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 09:05:05 pi4test systemd[1]: mpd.service: Deactivated successfully. Oct 16 09:05:05 pi4test systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 16 09:05:05 pi4test systemd[1]: mpd.service: Consumed 1.401s CPU time. Oct 16 09:05:05 pi4test systemd[1]: mpd.socket: Deactivated successfully. Oct 16 09:05:05 pi4test systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 16 09:05:05 pi4test systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 16 09:05:05 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 09:05:05 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 09:05:05 pi4test systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 16 09:05:05 pi4test systemd[1]: Starting mpd.service - Music Player Daemon... Oct 16 09:05:05 pi4test volumio[1197]: info: Starting Shairport Sync Oct 16 09:05:05 pi4test sudo[2414]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 16 09:05:05 pi4test sudo[2414]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 09:05:05 pi4test systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 16 09:05:05 pi4test sudo[2412]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 16 09:05:05 pi4test systemd[1]: shairport-sync.service: Deactivated successfully. Oct 16 09:05:05 pi4test sudo[2412]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 16 09:05:05 pi4test systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 16 09:05:05 pi4test sudo[2412]: pam_unix(sudo:session): session closed for user root Oct 16 09:05:05 pi4test systemd[1]: shairport-sync.service: Consumed 1.948s CPU time. Oct 16 09:05:05 pi4test systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 16 09:05:05 pi4test sudo[2414]: pam_unix(sudo:session): session closed for user root Oct 16 09:05:05 pi4test volumio[1197]: info: Shairport-Sync Started Oct 16 09:05:08 pi4test sshd[2433]: Accepted publickey for volumio from 192.168.30.10 port 55232 ssh2: RSA SHA256:sWbjE//P/1DZ7B1rDIsILI6jb/aFSwbMBkOgjWJbRNU Oct 16 09:05:08 pi4test sshd[2433]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Oct 16 09:05:08 pi4test systemd-logind[719]: New session 8 of user volumio. Oct 16 09:05:08 pi4test systemd[1]: Started session-8.scope - Session 8 of User volumio. Oct 16 09:05:08 pi4test sshd[2433]: pam_env(sshd:session): deprecated reading of user environment enabled Oct 16 09:05:08 pi4test volumio[1197]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 09:05:09 pi4test volumio[1197]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 16 09:05:09 pi4test volumio[1197]: info: Disabling plugin undefined Oct 16 09:05:09 pi4test volumio[1197]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 09:05:10 pi4test volumio[1197]: TypeError: Cannot read properties of undefined (reading 'volumio_info') Oct 16 09:05:10 pi4test volumio[1197]: at PluginManager.disablePlugin (/volumio/app/pluginmanager.js:1497:21) Oct 16 09:05:10 pi4test volumio[1197]: at CoreCommandRouter.disablePlugin (/volumio/app/index.js:1509:22) Oct 16 09:05:10 pi4test volumio[1197]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1326:45) Oct 16 09:05:10 pi4test volumio[1197]: at Socket.emit (node:events:514:28) Oct 16 09:05:10 pi4test volumio[1197]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 16 09:05:10 pi4test volumio[1197]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 16 09:05:10 pi4test volumio[1197]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 09:05:12 pi4test mpd[2418]: 2026-10-16T09:05:12 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 16 09:05:12 pi4test systemd[1]: Started mpd.service - Music Player Daemon. Oct 16 09:05:12 pi4test sudo[2399]: pam_unix(sudo:session): session closed for user root Oct 16 09:05:14 pi4test sudo[2495]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-16 09:04' Oct 16 09:05:14 pi4test sudo[2495]: 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="49c3b8c3d90722cb303dcca504ebce2ff3c7ebdf" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4bdfbfc68c4d22128e9bac172462cbd14ece0c88" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Oct 12 13:56:12 UTC 2026" VOLUMIO_VERSION="4.231" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="43f53a1f9ad8f3b898137f70f5cd23ce"