Apr 13 10:32:00 volumio-cpd volumio[2352]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/bookworm/armhf Apr 13 10:32:00 volumio-cpd volumio[2352]: info: Folder /tmp/plugins removed Apr 13 10:32:00 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:00.072+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:00 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:00.251+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:00 volumio-cpd volumio[2352]: info: Check plugin dependencies Apr 13 10:32:00 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 10:32:00 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:00.280+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:00 volumio-cpd volumio[2352]: info: Checking if plugin already exists Apr 13 10:32:00 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:00.282+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:00 volumio-cpd volumio[2352]: info: Rename folder Apr 13 10:32:00 volumio-cpd volumio[2352]: info: Folder /tmp/downloaded_plugin.zip removed Apr 13 10:32:00 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:00.306+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:00 volumio-cpd volumio[2352]: info: Move to category Apr 13 10:32:03 volumio-cpd volumio[2352]: info: Checking if install.sh is present Apr 13 10:32:03 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:03.519+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:03 volumio-cpd volumio[2352]: info: Executing install.sh Apr 13 10:32:03 volumio-cpd sudo[7395]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/system_hardware/mpd_oled/install.sh Apr 13 10:32:03 volumio-cpd sudo[7395]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 10:32:03 volumio-cpd sudo[7399]: root : PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/systemctl disable mpd_oled Apr 13 10:32:03 volumio-cpd sudo[7399]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 13 10:32:03 volumio-cpd sudo[7399]: pam_unix(sudo:session): session closed for user root Apr 13 10:32:03 volumio-cpd systemd[1]: Reloading. Apr 13 10:32:04 volumio-cpd systemd[1]: Reloading. Apr 13 10:32:05 volumio-cpd volumio[2352]: info: Installing i2c-tools for screen detection Apr 13 10:32:05 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:05.248+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:05 volumio-cpd sudo[7439]: root : PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/apt update Apr 13 10:32:05 volumio-cpd sudo[7439]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 13 10:32:05 volumio-cpd volumio[2352]: info: Installing i2c-tools for screen detection Apr 13 10:32:05 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:05.255+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:05 volumio-cpd volumio[2352]: info: Hit:1 http://archive.raspberrypi.com/debian bookworm InRelease Apr 13 10:32:05 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:05.867+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:05 volumio-cpd volumio[2352]: info: Hit:1 http://archive.raspberrypi.com/debian bookworm InRelease Apr 13 10:32:05 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:05.871+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:06 volumio-cpd volumio[2352]: info: Hit:2 http://raspbian.raspberrypi.com/raspbian bookworm InRelease Apr 13 10:32:06 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:06.197+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:06 volumio-cpd volumio[2352]: info: Hit:2 http://raspbian.raspberrypi.com/raspbian bookworm InRelease Apr 13 10:32:06 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:06.202+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:11 volumio-cpd volumio[2352]: info: Reading package lists... Apr 13 10:32:11 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:11.595+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:11 volumio-cpd volumio[2352]: info: Reading package lists... Apr 13 10:32:11 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:11.597+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:12 volumio-cpd volumio[2352]: info: Building dependency tree... Apr 13 10:32:12 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:12.254+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:12 volumio-cpd volumio[2352]: info: Building dependency tree... Apr 13 10:32:12 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:12.257+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:12 volumio-cpd volumio[2352]: info: Reading state information... Apr 13 10:32:12 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:12.762+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:12 volumio-cpd volumio[2352]: info: Reading state information... Apr 13 10:32:12 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:12.765+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:12 volumio-cpd volumio[2352]: info: 9 packages can be upgraded. Run 'apt list --upgradable' to see them. Apr 13 10:32:12 volumio-cpd sudo[7439]: pam_unix(sudo:session): session closed for user root Apr 13 10:32:12 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:12.840+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:12 volumio-cpd volumio[2352]: info: 9 packages can be upgraded. Run 'apt list --upgradable' to see them. Apr 13 10:32:12 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:12.843+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:12 volumio-cpd sudo[7590]: root : PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/apt-get --assume-yes install --no-install-recommends i2c-tools cava Apr 13 10:32:12 volumio-cpd sudo[7590]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 13 10:32:16 volumio-cpd sudo[7590]: pam_unix(sudo:session): session closed for user root Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Installing mpd_oled Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.630+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Installing mpd_oled Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.641+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd sudo[7600]: root : PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/cp -p /data/plugins/system_hardware/mpd_oled/mpd_oled /usr/local/bin/mpd_oled Apr 13 10:32:18 volumio-cpd sudo[7600]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 13 10:32:18 volumio-cpd sudo[7600]: pam_unix(sudo:session): session closed for user root Apr 13 10:32:18 volumio-cpd sudo[7612]: root : PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/chmod +x /usr/local/bin/mpd_oled Apr 13 10:32:18 volumio-cpd sudo[7612]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 13 10:32:18 volumio-cpd sudo[7612]: pam_unix(sudo:session): session closed for user root Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Checking I2C busses Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.701+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Checking I2C busses Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.709+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio[2352]: info: * I2C-1 bus enabled Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.729+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio[2352]: info: * I2C-0 bus enabled Apr 13 10:32:18 volumio-cpd sudo[7395]: pam_unix(sudo:session): session closed for user root Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.739+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio[2352]: info: * I2C-1 bus enabled Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.744+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio[2352]: info: * I2C-0 bus enabled Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.746+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Install script completed Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.762+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Adding reference to registry Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Done installing plugin. Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.769+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 10:32:18 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Folder /tmp/plugins removed Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Folder /tmp/downloaded_plugin.zip removed Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Setting I2C baudrate Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.822+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Enabling SPI Apr 13 10:32:18 volumio-cpd volumio[2352]: Plugin install end detected on script Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.837+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Setting I2C baudrate Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Enabling SPI Apr 13 10:32:18 volumio-cpd volumio[2352]: Plugin install end detected on script Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.847+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio5-onboarding[1396]: time=2026-04-13T10:32:18.852+07:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 13 10:32:18 volumio-cpd volumio[2352]: info: Folder /data/temp removed Apr 13 10:32:42 volumio-cpd volumio[2352]: info: Enabling plugin mpd_oled Apr 13 10:32:42 volumio-cpd volumio[2352]: info: Loading plugin "mpd_oled"... Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of OLED_TYPE to Select... Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of NUMBER_OF_BARS to 16 (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of GAP_BETWEEN_BARS to 1 (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of FRAME_RATE to 50 (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of SCROLL_RATE to 8 (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of SCROLL_DELAY to 5 (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of CLOCK_FORMAT to 24h leading 0 (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of PAUSE_SCREEN_TYPE to Play (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of INVERT_DISPLAY_PERIOD to Disabled (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of I2C_ADDRESS to Default for display Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of I2C_BUS to /dev/i2c-1 (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of SPI_RESET_GPIO_NUMBER to 25 (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of SPI_DC_GPIO_NUMBER to 24 (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of SPI_CS to 0 (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Translated default label of DATE_FORMAT to DD-MM-YYYY (default) Apr 13 10:32:42 volumio-cpd volumio[2352]: info: Preparing to generate the ALSA configuration file Apr 13 10:32:52 volumio-cpd volumio[2352]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Apr 13 10:32:52 volumio-cpd volumio[2352]: info: Reading ALSA contributions from plugins. Apr 13 10:32:53 volumio-cpd volumio[2352]: info: Asound.conf file written Apr 13 10:32:53 volumio-cpd sudo[7788]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 13 10:32:53 volumio-cpd sudo[7788]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 10:32:53 volumio-cpd sudo[7788]: pam_unix(sudo:session): session closed for user root Apr 13 10:32:53 volumio-cpd volumio[2352]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Apr 13 10:32:53 volumio-cpd volumio[2352]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Apr 13 10:32:53 volumio-cpd volumio[2352]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Apr 13 10:32:53 volumio-cpd volumio[2352]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Apr 13 10:32:53 volumio-cpd volumio[2352]: info: Output device has changed, restarting MPD Apr 13 10:32:53 volumio-cpd volumio[2352]: info: Output device has changed, restarting Shairport Sync Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:32:53 volumio-cpd sudo[7795]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 13 10:32:53 volumio-cpd sudo[7795]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 10:32:53 volumio-cpd sudo[7795]: pam_unix(sudo:session): session closed for user root Apr 13 10:32:53 volumio-cpd sudo[7797]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 13 10:32:53 volumio-cpd sudo[7797]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 10:32:53 volumio-cpd volumio[2352]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 13 10:32:53 volumio-cpd volumio[2352]: info: PLUGIN START: mpd_oled Apr 13 10:32:53 volumio-cpd systemd[1]: Stopping mpd.service - Music Player Daemon... Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 13 10:32:53 volumio-cpd volumio[2352]: info: [MPD_OLED Plugin] Not starting mpd_oled service because oled type is not configured yet Apr 13 10:32:53 volumio-cpd volumio[2352]: info: Preparing to generate the ALSA configuration file Apr 13 10:32:53 volumio-cpd volumio[2352]: info: Done. Apr 13 10:32:53 volumio-cpd volumio[2352]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Apr 13 10:32:53 volumio-cpd volumio[2352]: info: Reading ALSA contributions from plugins. Apr 13 10:32:53 volumio-cpd volumio[2352]: info: MPD Permissions set Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:32:53 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:53 volumio-cpd volumio[2352]: info: Asound.conf file unchanged, so no further update is needed Apr 13 10:32:53 volumio-cpd volumio[2352]: info: Output device has changed, restarting MPD Apr 13 10:32:54 volumio-cpd volumio[2352]: info: Output device has changed, restarting Shairport Sync Apr 13 10:32:54 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:54 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:32:54 volumio-cpd sudo[7826]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 13 10:32:54 volumio-cpd sudo[7827]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 13 10:32:54 volumio-cpd sudo[7827]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 10:32:54 volumio-cpd sudo[7826]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 10:32:54 volumio-cpd sudo[7826]: pam_unix(sudo:session): session closed for user root Apr 13 10:32:54 volumio-cpd volumio[2352]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 13 10:32:54 volumio-cpd volumio[2352]: info: MPD Permissions set Apr 13 10:32:54 volumio-cpd volumio[2352]: info: Starting Shairport Sync Apr 13 10:32:54 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:54 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:54 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:54 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:54 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:54 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:54 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:54 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:54 volumio-cpd sudo[7836]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 13 10:32:54 volumio-cpd sudo[7836]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 10:32:54 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 10:32:54 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 10:32:54 volumio-cpd systemd[1]: mpd.service: Deactivated successfully. Apr 13 10:32:54 volumio-cpd systemd[1]: Stopped mpd.service - Music Player Daemon. Apr 13 10:32:54 volumio-cpd systemd[1]: mpd.service: Consumed 1.507s CPU time. Apr 13 10:32:54 volumio-cpd systemd[1]: mpd.socket: Deactivated successfully. Apr 13 10:32:54 volumio-cpd systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Apr 13 10:32:54 volumio-cpd systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Apr 13 10:32:54 volumio-cpd volumio[2352]: info: Starting Shairport Sync Apr 13 10:32:54 volumio-cpd sudo[7847]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 13 10:32:54 volumio-cpd sudo[7847]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 10:32:54 volumio-cpd systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Apr 13 10:32:54 volumio-cpd systemd[1]: Starting mpd.service - Music Player Daemon... Apr 13 10:32:54 volumio-cpd systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Apr 13 10:32:54 volumio-cpd systemd[1]: shairport-sync.service: Deactivated successfully. Apr 13 10:32:54 volumio-cpd systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 13 10:32:54 volumio-cpd systemd[1]: shairport-sync.service: Consumed 5.300s CPU time. Apr 13 10:32:54 volumio-cpd systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 13 10:32:54 volumio-cpd sudo[7836]: pam_unix(sudo:session): session closed for user root Apr 13 10:32:54 volumio-cpd volumio[2352]: info: Shairport-Sync Started Apr 13 10:32:54 volumio-cpd systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Apr 13 10:32:54 volumio-cpd systemd[1]: shairport-sync.service: Deactivated successfully. Apr 13 10:32:54 volumio-cpd systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 13 10:32:54 volumio-cpd systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 13 10:32:54 volumio-cpd sudo[7847]: pam_unix(sudo:session): session closed for user root Apr 13 10:32:54 volumio-cpd volumio[2352]: info: Shairport-Sync Started Apr 13 10:32:54 volumio-cpd sudo[7849]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 13 10:32:54 volumio-cpd sudo[7849]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 13 10:32:54 volumio-cpd sudo[7849]: pam_unix(sudo:session): session closed for user root Apr 13 10:33:04 volumio-cpd mpd[7862]: 2026-04-13T10:33:04 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 13 10:33:04 volumio-cpd systemd[1]: Started mpd.service - Music Player Daemon. Apr 13 10:33:04 volumio-cpd sudo[7827]: pam_unix(sudo:session): session closed for user root Apr 13 10:33:04 volumio-cpd sudo[7797]: pam_unix(sudo:session): session closed for user root Apr 13 10:33:04 volumio-cpd volumio[2352]: error: MPD error: The expression evaluated to a falsy value: Apr 13 10:33:04 volumio-cpd volumio[2352]: assert.ok(self.idling) Apr 13 10:33:04 volumio-cpd volumio[2352]: error: The expression evaluated to a falsy value: Apr 13 10:33:04 volumio-cpd volumio[2352]: assert.ok(self.idling) Apr 13 10:33:04 volumio-cpd volumio[2352]: error: updateQueue error: null Apr 13 10:33:08 volumio-cpd volumio[2352]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 10:33:08 volumio-cpd volumio[2352]: info: touch_display: About to detect HDMI ports... Apr 13 10:33:08 volumio-cpd volumio[2352]: info: touch_display: X server not ready, cannot detect HDMI ports yet. Apr 13 10:33:11 volumio-cpd dbus-daemon[730]: [system] Reloaded configuration Apr 13 10:33:11 volumio-cpd shairport-sync[7857]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio5-onboarding[1396]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd dbus-daemon[730]: [system] Reloaded configuration Apr 13 10:33:11 volumio-cpd shairport-sync[7857]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio5-onboarding[1396]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd dbus-daemon[730]: [system] Reloaded configuration Apr 13 10:33:11 volumio-cpd shairport-sync[7857]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio5-onboarding[1396]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd dbus-daemon[730]: [system] Reloaded configuration Apr 13 10:33:11 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd shairport-sync[7857]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio5-onboarding[1396]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd dbus-daemon[730]: [system] Reloaded configuration Apr 13 10:33:11 volumio-cpd shairport-sync[7857]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio5-onboarding[1396]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd dbus-daemon[730]: [system] Reloaded configuration Apr 13 10:33:11 volumio-cpd shairport-sync[7857]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio5-onboarding[1396]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:11 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:12 volumio-cpd systemd[1]: Reloading. Apr 13 10:33:14 volumio-cpd dbus-daemon[730]: [system] Reloaded configuration Apr 13 10:33:14 volumio-cpd shairport-sync[7857]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:14 volumio-cpd volumio5-onboarding[1396]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:14 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:14 volumio-cpd volumio[2352]: WARNING: Unhandled message: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=ActivatableServicesChanged Apr 13 10:33:17 volumio-cpd volumio[2352]: info: CALLMETHOD: user_interface touch_display saveScreensaverConf [object Object] Apr 13 10:33:17 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: touch_display , saveScreensaverConf Apr 13 10:33:17 volumio-cpd volumio[2352]: error: touch_display: Error waking up the screen: Error: Command failed: /usr/bin/xset -display :undefined s reset dpms force on Apr 13 10:33:17 volumio-cpd volumio[2352]: /usr/bin/xset: unable to open display ":undefined" Apr 13 10:33:17 volumio-cpd volumio[2352]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/Xundefined' Apr 13 10:33:19 volumio-cpd volumio[2352]: info: CALLMETHOD: user_interface touch_display saveScreensaverConf [object Object] Apr 13 10:33:19 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: touch_display , saveScreensaverConf Apr 13 10:33:23 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 10:33:23 volumio-cpd volumio[2352]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 13 10:33:30 volumio-cpd volumio[2352]: info: Starting Uninstall of plugin user_interface - touch_display Apr 13 10:33:30 volumio-cpd volumio[2352]: info: Uninstalling plugin touch_display Apr 13 10:33:30 volumio-cpd sudo[8221]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Apr 13 10:33:30 volumio-cpd sudo[8221]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 10:33:30 volumio-cpd sudo[8223]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Apr 13 10:33:30 volumio-cpd sudo[8223]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 10:33:30 volumio-cpd sudo[8221]: pam_unix(sudo:session): session closed for user root Apr 13 10:33:30 volumio-cpd volumio[2352]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Apr 13 10:33:30 volumio-cpd volumio[2352]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 10:33:30 volumio-cpd sudo[8225]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Apr 13 10:33:30 volumio-cpd sudo[8225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 10:33:30 volumio-cpd sudo[8229]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Apr 13 10:33:30 volumio-cpd volumio[2352]: TypeError: Cannot read properties of undefined (reading 'split') Apr 13 10:33:30 volumio-cpd volumio[2352]: at /data/plugins/user_interface/touch_display/index.js:1298:37 Apr 13 10:33:30 volumio-cpd volumio[2352]: at ChildProcess.exithandler (node:child_process:413:7) Apr 13 10:33:30 volumio-cpd volumio[2352]: at ChildProcess.emit (node:events:514:28) Apr 13 10:33:30 volumio-cpd volumio[2352]: at maybeClose (node:internal/child_process:1105:16) Apr 13 10:33:30 volumio-cpd volumio[2352]: at Socket. (node:internal/child_process:457:11) Apr 13 10:33:30 volumio-cpd volumio[2352]: at Socket.emit (node:events:514:28) Apr 13 10:33:30 volumio-cpd volumio[2352]: at Pipe. (node:net:337:12) Apr 13 10:33:30 volumio-cpd volumio[2352]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 10:33:30 volumio-cpd sudo[8229]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 10:33:30 volumio-cpd sudo[8229]: pam_unix(sudo:session): session closed for user root Apr 13 10:33:31 volumio-cpd systemd[1]: Started getty@tty1.service - Getty on tty1. Apr 13 10:33:31 volumio-cpd sudo[8223]: pam_unix(sudo:session): session closed for user root Apr 13 10:33:31 volumio-cpd systemd[1]: Reloading. Apr 13 10:33:31 volumio-cpd sudo[8264]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-13 10:32' Apr 13 10:33:31 volumio-cpd sudo[8264]: 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"