May 26 11:54:28 volumio sudo[16089]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 11:54:28 volumio sudo[16089]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:28 volumio sudo[16089]: pam_unix(sudo:session): session closed for user root May 26 11:54:28 volumio sudo[16091]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 11:54:28 volumio sudo[16091]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:28 volumio sudo[16091]: pam_unix(sudo:session): session closed for user root May 26 11:54:28 volumio volumio[1254]: verbose: New Socket.io Connection to 192.168.15.26 from 192.168.15.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 9 May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::volumioGetVisibleSources May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:28 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 26 11:54:28 volumio volumio[1254]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 26 11:54:28 volumio volumio[1254]: info: Received Get System Info May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 11:54:28 volumio volumio[1254]: info: Discovery: Getting this device information May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:28 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:28 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:28 volumio volumio[1254]: info: Listing playlists May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 11:54:28 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 26 11:54:29 volumio sudo[16109]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 11:54:29 volumio sudo[16109]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:29 volumio sudo[16109]: pam_unix(sudo:session): session closed for user root May 26 11:54:29 volumio sudo[16111]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 11:54:29 volumio sudo[16111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:29 volumio sudo[16111]: pam_unix(sudo:session): session closed for user root May 26 11:54:29 volumio volumio[1254]: verbose: New Socket.io Connection to 192.168.15.26 from 192.168.15.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 9 May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::volumioGetVisibleSources May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:29 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 26 11:54:29 volumio volumio[1254]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 26 11:54:29 volumio volumio[1254]: info: Received Get System Info May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 11:54:29 volumio volumio[1254]: info: Discovery: Getting this device information May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:29 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:29 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:29 volumio volumio[1254]: info: Listing playlists May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 11:54:29 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 26 11:54:30 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:30 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:30 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 26 11:54:31 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 11:54:31 volumio volumio[1254]: info: Received Get System Info May 26 11:54:31 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 11:54:31 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 11:54:31 volumio volumio[1254]: info: Discovery: Getting this device information May 26 11:54:31 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:31 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:31 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 11:54:32 volumio volumio[1254]: info: Executing endpoint metavolumio May 26 11:54:32 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 26 11:54:32 volumio volumio[1254]: info: Executing endpoint metavolumio May 26 11:54:32 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 26 11:54:32 volumio volumio[1254]: info: Executing endpoint metavolumio May 26 11:54:32 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 26 11:54:32 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 11:54:32 volumio volumio[1254]: info: Received Get System Info May 26 11:54:32 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 11:54:32 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 11:54:32 volumio volumio[1254]: info: Discovery: Getting this device information May 26 11:54:32 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:32 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:32 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 11:54:36 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 11:54:36 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 26 11:54:38 volumio volumio5-onboarding[1542]: time=2026-05-26T11:54:38.062-03:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.15.19:63523 error="websocket: close 1006 (abnormal closure): unexpected EOF" May 26 11:54:38 volumio volumio5-onboarding[1542]: time=2026-05-26T11:54:38.062-03:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.15.19:63523 May 26 11:54:38 volumio volumio5-onboarding[1542]: time=2026-05-26T11:54:38.062-03:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.15.19:63523 May 26 11:54:39 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 26 11:54:39 volumio volumio[1254]: error: Failed request for metavolumio API May 26 11:54:39 volumio volumio[1254]: error: Failed request for metavolumio API May 26 11:54:39 volumio volumio[1254]: error: Failed request for metavolumio API May 26 11:54:42 volumio volumio[1254]: info: Enabling plugin touch_display May 26 11:54:42 volumio volumio[1254]: info: Loading plugin "touch_display"... May 26 11:54:42 volumio volumio[1254]: info: Applying required configuration parameters for plugin touch_display May 26 11:54:42 volumio volumio[1254]: info: PLUGIN START: touch_display May 26 11:54:42 volumio volumio[1254]: info: Loading i18n strings for locale en May 26 11:54:42 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 11:54:42 volumio sudo[16131]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service May 26 11:54:42 volumio sudo[16131]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:42 volumio volumio[1254]: info: touch_display: No backlight interface detected. May 26 11:54:42 volumio sudo[16133]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service May 26 11:54:42 volumio sudo[16133]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:42 volumio sudo[16136]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload May 26 11:54:42 volumio sudo[16136]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:42 volumio systemd[1]: Stopping getty@tty1.service - Getty on tty1... May 26 11:54:42 volumio systemd[1]: getty@tty1.service: Deactivated successfully. May 26 11:54:42 volumio systemd[1]: Stopped getty@tty1.service - Getty on tty1. May 26 11:54:42 volumio volumio[1254]: info: touch_display: No Raspberry Pi Foundation touch screen detected. May 26 11:54:42 volumio sudo[16140]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf May 26 11:54:42 volumio sudo[16140]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:42 volumio sudo[16140]: pam_unix(sudo:session): session closed for user root May 26 11:54:42 volumio sudo[16142]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf May 26 11:54:42 volumio sudo[16142]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:42 volumio sudo[16131]: pam_unix(sudo:session): session closed for user root May 26 11:54:42 volumio volumio[1254]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. May 26 11:54:42 volumio sudo[16142]: pam_unix(sudo:session): session closed for user root May 26 11:54:42 volumio volumio[1254]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. May 26 11:54:42 volumio volumio[1254]: info: touch_display: systemctl stop getty@tty1.service succeeded. May 26 11:54:42 volumio volumio[1254]: info: touch_display: Rotation settings written to /etc/X11/xorg.conf.d/95-touch_display-plugin.conf. May 26 11:54:42 volumio systemd[1]: Reloading. May 26 11:54:43 volumio volumio[1254]: info: Enabling plugin touch_display May 26 11:54:43 volumio volumio[1254]: info: Loading plugin "touch_display"... May 26 11:54:43 volumio volumio[1254]: info: Applying required configuration parameters for plugin touch_display May 26 11:54:43 volumio volumio[1254]: info: PLUGIN START: touch_display May 26 11:54:43 volumio volumio[1254]: info: Loading i18n strings for locale en May 26 11:54:43 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 11:54:43 volumio sudo[16164]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service May 26 11:54:43 volumio sudo[16164]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:43 volumio sudo[16166]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service May 26 11:54:43 volumio sudo[16166]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:43 volumio volumio[1254]: info: touch_display: No backlight interface detected. May 26 11:54:43 volumio sudo[16169]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload May 26 11:54:43 volumio sudo[16169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:43 volumio volumio[1254]: info: touch_display: No Raspberry Pi Foundation touch screen detected. May 26 11:54:43 volumio sudo[16173]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf May 26 11:54:43 volumio sudo[16173]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:43 volumio sudo[16173]: pam_unix(sudo:session): session closed for user root May 26 11:54:43 volumio sudo[16175]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf May 26 11:54:43 volumio sudo[16175]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:43 volumio volumio[1254]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. May 26 11:54:43 volumio sudo[16175]: pam_unix(sudo:session): session closed for user root May 26 11:54:43 volumio volumio[1254]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. May 26 11:54:43 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:43 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:43 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:43 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:43 volumio sudo[16136]: pam_unix(sudo:session): session closed for user root May 26 11:54:43 volumio volumio[1254]: info: touch_display: systemctl daemon-reload succeeded. May 26 11:54:43 volumio systemd[1]: Reloading. May 26 11:54:43 volumio sudo[16179]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service May 26 11:54:43 volumio sudo[16179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:44 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:44 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:44 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:44 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:44 volumio sudo[16133]: pam_unix(sudo:session): session closed for user root May 26 11:54:44 volumio volumio[1254]: info: touch_display: systemctl disable getty@tty1.service succeeded. May 26 11:54:44 volumio systemd[1]: Reloading. May 26 11:54:44 volumio volumio[1254]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 11:54:44 volumio volumio[1254]: info: touch_display: About to detect HDMI ports... May 26 11:54:44 volumio volumio[1254]: info: touch_display: Detected HDMI ports: HDMI 0 (HDMI-A-1), HDMI 1 (HDMI-A-2) May 26 11:54:45 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:45 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:45 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:45 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:45 volumio sudo[16169]: pam_unix(sudo:session): session closed for user root May 26 11:54:45 volumio systemd[1]: Reloading. May 26 11:54:45 volumio volumio[1254]: info: touch_display: systemctl daemon-reload succeeded. May 26 11:54:45 volumio sudo[16216]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service May 26 11:54:45 volumio sudo[16216]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:45 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:45 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:46 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:46 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:54:46 volumio sudo[16166]: pam_unix(sudo:session): session closed for user root May 26 11:54:46 volumio volumio[1254]: info: touch_display: systemctl disable getty@tty1.service succeeded. May 26 11:54:46 volumio systemd[1]: Started volumio-kiosk.service - Volumio Kiosk. May 26 11:54:46 volumio sudo[16216]: pam_unix(sudo:session): session closed for user root May 26 11:54:46 volumio sudo[16179]: pam_unix(sudo:session): session closed for user root May 26 11:54:46 volumio volumio[1254]: info: touch_display: systemctl start volumio-kiosk.service succeeded. May 26 11:54:46 volumio volumio[1254]: info: touch_display: Volumio Kiosk started. May 26 11:54:46 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:46 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:46 volumio sudo[16164]: pam_unix(sudo:session): session closed for user root May 26 11:54:46 volumio volumio[1254]: info: Done. May 26 11:54:46 volumio volumio[1254]: info: touch_display: systemctl start volumio-kiosk.service succeeded. May 26 11:54:46 volumio volumio[1254]: info: touch_display: Volumio Kiosk started. May 26 11:54:46 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:46 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:46 volumio volumio[1254]: info: Done. May 26 11:54:46 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:46 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:46 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState May 26 11:54:46 volumio volumio[1254]: info: CorePlayQueue::getTrack 20 May 26 11:54:46 volumio volumio[1254]: info: touch_display: systemctl stop getty@tty1.service succeeded. May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio startx[16264]: X.Org X Server 1.21.1.7 May 26 11:54:46 volumio startx[16264]: X Protocol Version 11, Revision 0 May 26 11:54:46 volumio startx[16264]: Current Operating System: Linux volumio 6.12.74-v7l+ #1948 SMP Mon Mar 2 11:27:49 GMT 2026 armv7l May 26 11:54:46 volumio startx[16264]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave nvme.max_host_mem_size_mb=0 snd_bcm2835.enable_hdmi=0 video=HDMI-A-1:640x480M@60D numa=fake=2 system_heap.max_order=0 iommu_dma_numa_policy=interleave smsc95xx.macaddr=D8:3A:DD:3C:96:7F vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=9caf6474-168f-4972-add4-ace36a467bc2 imgfile=/volumio_current.sqsh bootpart=UUID=807D-2966 datapart=UUID=bea3e05c-62cf-4b22-a58d-66213927f56a uuidconfig=cmdline.txt rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no May 26 11:54:46 volumio startx[16264]: xorg-server 2:21.1.7-3+rpt3+deb12u11 (https://www.debian.org/support) May 26 11:54:46 volumio startx[16264]: Current version of pixman: 0.44.0 May 26 11:54:46 volumio startx[16264]: Before reporting problems, check http://wiki.x.org May 26 11:54:46 volumio startx[16264]: to make sure that you have the latest version. May 26 11:54:46 volumio startx[16264]: Markers: (--) probed, (**) from config file, (==) default setting, May 26 11:54:46 volumio startx[16264]: (++) from command line, (!!) notice, (II) informational, May 26 11:54:46 volumio startx[16264]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. May 26 11:54:46 volumio startx[16264]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue May 26 11:54:46 2026 May 26 11:54:46 volumio startx[16264]: (==) Using config directory: "/etc/X11/xorg.conf.d" May 26 11:54:46 volumio startx[16264]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: X display number found: 0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 26 11:54:46 volumio volumio[1254]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 26 11:54:46 volumio volumio[1254]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 11:54:46 volumio volumio[1254]: Error: connect EISCONN /tmp/.X11-unix/X0 May 26 11:54:46 volumio volumio[1254]: at PipeConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { May 26 11:54:46 volumio volumio[1254]: errno: -106, May 26 11:54:46 volumio volumio[1254]: code: 'EISCONN', May 26 11:54:46 volumio volumio[1254]: syscall: 'connect', May 26 11:54:46 volumio volumio[1254]: address: '/tmp/.X11-unix/X0' May 26 11:54:46 volumio volumio[1254]: } May 26 11:54:46 volumio volumio[1254]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 11:54:47 volumio sudo[16319]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-26 11:53' May 26 11:54:47 volumio sudo[16319]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:47 volumio sudo[16319]: pam_unix(sudo:session): session closed for user root May 26 11:54:48 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 26 11:54:48 volumio volumio-remote-updater[831]: [2026-05-26 11:54:48] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 26 11:54:48 volumio volumio-remote-updater[831]: [2026-05-26 11:54:48] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 26 11:54:48 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. May 26 11:54:48 volumio systemd[1]: volumio.service: Consumed 23min 13.307s CPU time. May 26 11:54:48 volumio volumio5-onboarding[1542]: time=2026-05-26T11:54:48.544-03:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" May 26 11:54:48 volumio qobuz-connect[5485]: 20260526 11:54:48.599 [5485.5485] INFO SampleApp: Socket closed May 26 11:54:48 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. May 26 11:54:48 volumio go-librespot[3364]: time="2026-05-26T11:54:48-03:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" May 26 11:54:48 volumio systemd[1]: upmpdcli.service: Deactivated successfully. May 26 11:54:48 volumio systemd[1]: upmpdcli.service: Consumed 1min 984ms CPU time. May 26 11:54:48 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. May 26 11:54:48 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. May 26 11:54:48 volumio systemd[1]: volumio.service: Consumed 23min 13.307s CPU time. May 26 11:54:48 volumio vtcs[5504]: [2026-05-26 11:54:48.529] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected May 26 11:54:48 volumio systemd[1]: Started volumio.service - Volumio Backend Module. May 26 11:54:48 volumio systemd[1]: dynamicswap.service: Deactivated successfully. May 26 11:54:48 volumio volumio5-onboarding[1542]: time=2026-05-26T11:54:48.776-03:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" May 26 11:54:49 volumio volumio5-onboarding[1542]: time=2026-05-26T11:54:49.778-03:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" May 26 11:54:51 volumio volumio[16353]: info: ------------------------------------------- May 26 11:54:51 volumio volumio[16353]: info: ----- Volumio3 ---- May 26 11:54:51 volumio volumio[16353]: info: ------------------------------------------- May 26 11:54:51 volumio volumio[16353]: info: ----- System startup ---- May 26 11:54:51 volumio volumio[16353]: info: ------------------------------------------- May 26 11:54:51 volumio volumio[16353]: info: MYVOLUMIO Environment detected May 26 11:54:52 volumio volumio[16353]: info: Plugin folders cleanup May 26 11:54:52 volumio volumio[16353]: info: Scanning into folder /volumio/app/plugins/ May 26 11:54:52 volumio volumio[16353]: info: Scanning category audio_interface May 26 11:54:52 volumio volumio[16353]: info: Scanning category miscellanea May 26 11:54:52 volumio volumio[16353]: info: Scanning category music_service May 26 11:54:52 volumio volumio[16353]: info: Scanning category plugins.json May 26 11:54:52 volumio volumio[16353]: info: Scanning category system_controller May 26 11:54:52 volumio volumio[16353]: info: Scanning category user_interface May 26 11:54:52 volumio volumio[16353]: info: Scanning into folder /data/plugins/ May 26 11:54:52 volumio volumio[16353]: info: Scanning category music_service May 26 11:54:52 volumio volumio[16353]: info: Scanning category system_hardware May 26 11:54:52 volumio volumio[16353]: info: Scanning category user_interface May 26 11:54:52 volumio volumio[16353]: info: Plugin folders cleanup completed May 26 11:54:52 volumio volumio[16353]: info: ------------------------------------------- May 26 11:54:52 volumio volumio[16353]: info: ----- Core plugins startup ---- May 26 11:54:52 volumio volumio[16353]: info: ------------------------------------------- May 26 11:54:52 volumio volumio[16353]: info: Loading plugins from folder /volumio/app/plugins/ May 26 11:54:52 volumio volumio[16353]: info: Adding plugin upnp to MyMusic Plugins May 26 11:54:52 volumio volumio[16353]: info: Adding plugin airplay_emulation to MyMusic Plugins May 26 11:54:52 volumio volumio[16353]: info: Adding plugin upnp_browser to MyMusic Plugins May 26 11:54:52 volumio volumio[16353]: info: Loading plugins from folder /data/plugins/ May 26 11:54:52 volumio volumio[16353]: info: Loading plugin "system"... May 26 11:54:52 volumio volumio[16353]: info: Loading plugin "appearance"... May 26 11:54:53 volumio volumio-remote-updater[831]: [2026-05-26 11:54:53] [connect] Successful connection May 26 11:54:53 volumio volumio[16353]: info: Loading plugin "network"... May 26 11:54:53 volumio volumio[16353]: info: Refreshing Cached IP Addresses May 26 11:54:53 volumio sudo[16574]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 11:54:53 volumio sudo[16574]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:53 volumio sudo[16574]: pam_unix(sudo:session): session closed for user root May 26 11:54:53 volumio sudo[16576]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 11:54:53 volumio volumio[16353]: info: Loading plugin "services"... May 26 11:54:53 volumio sudo[16576]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:53 volumio volumio[16353]: info: Loading plugin "volumio5onboarding"... May 26 11:54:53 volumio sudo[16576]: pam_unix(sudo:session): session closed for user root May 26 11:54:53 volumio sudo[16588]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 26 11:54:53 volumio sudo[16588]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:53 volumio volumio[16353]: info: Loading plugin "alsa_controller"... May 26 11:54:53 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 11:54:53 volumio volumio[16353]: info: Loading plugin "wizard"... May 26 11:54:53 volumio volumio[16353]: info: Loading plugin "networkfs"... May 26 11:54:53 volumio volumio[16353]: info: Starting Udev Watcher for removable devices May 26 11:54:53 volumio volumio[16353]: info: Ignoring mount for partition: boot May 26 11:54:53 volumio volumio[16353]: info: Ignoring mount for partition: volumio May 26 11:54:53 volumio volumio[16353]: info: Ignoring mount for partition: volumio_data May 26 11:54:53 volumio volumio[16353]: info: Mounting Device 6C6D-7BDB May 26 11:54:53 volumio sudo[16610]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/6C6D-7BDB -o noatime,dmask=0000,fmask=0000,iocharset=utf8 May 26 11:54:53 volumio sudo[16610]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:54:54 volumio sudo[16610]: pam_unix(sudo:session): session closed for user root May 26 11:54:54 volumio volumio[16353]: mount: /media/6C6D-7BDB: /dev/sda1 already mounted on /media/6C6D-7BDB. May 26 11:54:54 volumio volumio[16353]: dmesg(1) may have more information after failed mount system call. May 26 11:54:54 volumio volumio[16353]: error: Failed to mount 6C6D-7BDB: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/6C6D-7BDB" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 May 26 11:54:54 volumio volumio[16353]: mount: /media/6C6D-7BDB: /dev/sda1 already mounted on /media/6C6D-7BDB. May 26 11:54:54 volumio volumio[16353]: dmesg(1) may have more information after failed mount system call. May 26 11:54:54 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 26 11:54:54 volumio volumio[16353]: info: Loading plugin "volumio_command_line_client"... May 26 11:54:54 volumio volumio[16353]: info: Loading plugin "upnp"... May 26 11:54:54 volumio volumio[16353]: info: [1779807294097] Starting Upmpd Daemon May 26 11:54:54 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 26 11:54:54 volumio volumio[16353]: info: Loading plugin "my_music"... May 26 11:54:54 volumio volumio[16353]: info: Loading plugin "mpd"... May 26 11:54:54 volumio volumio[16353]: info: Loading plugin "upnp_browser"... May 26 11:54:55 volumio volumio[16353]: info: Starting UPNP Browser May 26 11:54:55 volumio volumio[16353]: info: Loading plugin "alarm-clock"... May 26 11:54:55 volumio volumio[16353]: info: Loading plugin "airplay_emulation"... May 26 11:54:55 volumio volumio[16353]: info: Starting Shairport Sync May 26 11:54:55 volumio volumio[16353]: info: Loading plugin "last_100"... May 26 11:54:55 volumio volumio[16353]: info: Loading plugin "webradio"... May 26 11:54:55 volumio volumio[16353]: info: Loading plugin "i2s_dacs"... May 26 11:54:55 volumio volumio[16353]: info: I2S DAC not set, start Auto-detection May 26 11:54:55 volumio volumio[16353]: info: Loading plugin "volumiodiscovery"... May 26 11:54:55 volumio volumio[16353]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 26 11:54:55 volumio node[16353]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 26 11:54:55 volumio volumio[16353]: *** WARNING *** Please fix your application to use the native API of Avahi! May 26 11:54:55 volumio node[16353]: *** WARNING *** Please fix your application to use the native API of Avahi! May 26 11:54:55 volumio volumio[16353]: *** WARNING *** For more information see May 26 11:54:55 volumio node[16353]: *** WARNING *** For more information see May 26 11:54:55 volumio volumio[16353]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 26 11:54:55 volumio node[16353]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 26 11:54:55 volumio volumio[16353]: *** WARNING *** Please fix your application to use the native API of Avahi! May 26 11:54:55 volumio node[16353]: *** WARNING *** Please fix your application to use the native API of Avahi! May 26 11:54:55 volumio volumio[16353]: *** WARNING *** For more information see May 26 11:54:55 volumio node[16353]: *** WARNING *** For more information see May 26 11:54:55 volumio volumio[16353]: info: Applying required configuration parameters for plugin volumiodiscovery May 26 11:54:55 volumio volumio[16353]: info: Discovery: Started advertising with name: Volumio May 26 11:54:55 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 26 11:54:55 volumio volumio[16353]: info: Loading plugin "spop"... May 26 11:54:56 volumio sudo[16588]: pam_unix(sudo:session): session closed for user root May 26 11:54:57 volumio volumio[16353]: info: Plugin ytmusic is not enabled May 26 11:54:57 volumio volumio[16353]: info: Loading plugin "gpio-buttons"... May 26 11:54:58 volumio volumio[16353]: gpiox_arm32 V2.2.1 May 26 11:54:58 volumio volumio[16353]: info: gpio-buttons: Initialized May 26 11:54:58 volumio volumio[16353]: info: Loading plugin "outputs"... May 26 11:54:58 volumio volumio[16353]: info: Loading plugin "albumart"... May 26 11:54:58 volumio volumio[16353]: info: Plugin example_plugin is not enabled May 26 11:54:58 volumio volumio[16353]: info: Loading plugin "inputs"... May 26 11:54:58 volumio volumio[16353]: info: Loading plugin "updater_comm"... May 26 11:54:58 volumio volumio[16353]: info: Plugin mpdemulation is not enabled May 26 11:54:58 volumio volumio[16353]: info: Loading plugin "rest_api"... May 26 11:54:58 volumio volumio[16353]: info: Loading plugin "websocket"... May 26 11:54:58 volumio volumio[16353]: info: Starting Socket.io Server version 1.7.4 May 26 11:54:58 volumio volumio[16353]: info: Plugin peppymeterbasic is not enabled May 26 11:54:58 volumio volumio[16353]: info: Loading plugin "touch_display"... May 26 11:54:58 volumio volumio[16353]: info: Applying required configuration parameters for plugin touch_display May 26 11:54:58 volumio volumio[16684]: Forking 3 albumart workers May 26 11:54:58 volumio volumio[16353]: info: Loading i18n strings for locale en May 26 11:54:58 volumio volumio[16353]: Updating browse sources language May 26 11:54:58 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 11:54:58 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 11:54:58 volumio volumio[16353]: info: CoreCommandRouter::initPlayerControls May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 11:54:59 volumio volumio[16353]: Express server listening on port 3000 May 26 11:54:59 volumio volumio[16353]: [Metrics] WebUI: 8s 874.56ms May 26 11:54:59 volumio volumio[16353]: info: CoreStateMachine::resetVolumioState May 26 11:54:59 volumio volumio[16353]: info: CoreStateMachine::getcurrentVolume May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::volumioRetrievevolume May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:54:59 volumio volumio[16353]: info: Volumio Network Manager: Network status updated: 1 May 26 11:54:59 volumio volumio[16353]: info: CoreStateMachine::pushState May 26 11:54:59 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::volumioPushState May 26 11:54:59 volumio volumio[16353]: info: CoreStateMachine::updateTrackBlock May 26 11:54:59 volumio volumio[16353]: info: CorePlayQueue::getTrackBlock May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::volumioRetrievevolume May 26 11:54:59 volumio volumio[16353]: verbose: New Socket.io Connection to 192.168.15.26 from 192.168.15.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 1 May 26 11:54:59 volumio volumio[16353]: info: Reloading queue from file May 26 11:54:59 volumio volumio[16353]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 May 26 11:54:59 volumio volumio[16353]: info: CoreStateMachine::pushState May 26 11:54:59 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::volumioPushState May 26 11:54:59 volumio volumio[16353]: info: CoreStateMachine::setRepeat false single undefined May 26 11:54:59 volumio volumio[16353]: info: CoreStateMachine::pushState May 26 11:54:59 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::volumioPushState May 26 11:54:59 volumio volumio[16353]: info: CoreStateMachine::setRandom null May 26 11:54:59 volumio volumio[16353]: info: CoreStateMachine::pushState May 26 11:54:59 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::volumioPushState May 26 11:54:59 volumio volumio[16695]: Starting albumart workers May 26 11:54:59 volumio volumio[16353]: info: Setting Device type: Raspberry PI May 26 11:54:59 volumio volumio[16353]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 May 26 11:54:59 volumio volumio[16353]: info: Received Get System Info May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 11:54:59 volumio volumio[16353]: info: Discovery: Getting this device information May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:54:59 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 11:54:59 volumio volumio[16696]: Starting albumart workers May 26 11:54:59 volumio volumio[16353]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb May 26 11:54:59 volumio volumio[16353]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 May 26 11:54:59 volumio volumio[16353]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 11:54:59 volumio volumio[16353]: verbose: New Socket.io Connection to 192.168.15.26 from 192.168.15.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 3 May 26 11:54:59 volumio volumio[16353]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 May 26 11:54:59 volumio volumio[16353]: info: Completed loading Core Plugins May 26 11:54:59 volumio volumio[16353]: info: Preparing to generate the ALSA configuration file May 26 11:54:59 volumio volumio[16694]: Starting albumart workers May 26 11:54:59 volumio volumio[16353]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 May 26 11:54:59 volumio volumio[16353]: info: Discovery: adding 3302251e-9610-409b-94ab-92ab16433f56 May 26 11:54:59 volumio volumio[16353]: info: Discovery: Found device Volumio May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:54:59 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:54:59 volumio volumio[16353]: info: Discovery: this is already registered, 3302251e-9610-409b-94ab-92ab16433f56 May 26 11:54:59 volumio volumio[16353]: info: Discovery: Found device Volumio May 26 11:54:59 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:54:59 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:54:59 volumio volumio[16353]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 26 11:54:59 volumio volumio[16353]: info: Reading ALSA contributions from plugins. May 26 11:54:59 volumio volumio[16353]: info: gpio-buttons: Socket connected to Volumio May 26 11:55:00 volumio volumio[16353]: info: Asound.conf file written May 26 11:55:00 volumio sudo[16762]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 26 11:55:00 volumio sudo[16762]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:00 volumio sudo[16762]: pam_unix(sudo:session): session closed for user root May 26 11:55:00 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 May 26 11:55:00 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 May 26 11:55:00 volumio volumio[16353]: /usr/share/alsa/init/bcm2835:14: control element not found May 26 11:55:00 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 May 26 11:55:00 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 May 26 11:55:00 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 May 26 11:55:00 volumio volumio[16353]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:85dd" "" "" May 26 11:55:00 volumio volumio[16353]: Hardware is initialized using a generic method May 26 11:55:00 volumio volumio[16353]: info: Output device has changed, restarting MPD May 26 11:55:00 volumio sudo[16774]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 26 11:55:00 volumio sudo[16774]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:00 volumio volumio[16353]: info: Output device has changed, restarting Shairport Sync May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:00 volumio sudo[16774]: pam_unix(sudo:session): session closed for user root May 26 11:55:00 volumio sudo[16776]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 26 11:55:00 volumio sudo[16776]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:00 volumio volumio[16353]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 26 11:55:00 volumio volumio[16353]: info: ___________ START PLUGINS ___________ May 26 11:55:00 volumio systemd[1]: mpd.socket: Deactivated successfully. May 26 11:55:00 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 26 11:55:00 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 26 11:55:00 volumio volumio[16353]: info: ControllerMpd::onStart: Initializing MPD May 26 11:55:00 volumio volumio[16353]: info: Creating MPD Configuration file May 26 11:55:00 volumio sudo[16784]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service May 26 11:55:00 volumio sudo[16784]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 26 11:55:00 volumio sudo[16787]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 26 11:55:00 volumio volumio[16353]: info: [1779807300286] CoreMusicLibrary::Adding element Media Servers May 26 11:55:00 volumio sudo[16787]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 11:55:00 volumio sudo[16787]: pam_unix(sudo:session): session closed for user root May 26 11:55:00 volumio sudo[16790]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 26 11:55:00 volumio sudo[16790]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:00 volumio volumio[16353]: info: UPNP Browser: Client initialized successfully May 26 11:55:00 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 26 11:55:00 volumio systemd[1]: Starting mpd.service - Music Player Daemon... May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:00 volumio volumio[16353]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 26 11:55:00 volumio volumio5-onboarding[1542]: time=2026-05-26T11:55:00.349-03:00 level=INFO msg="service successfully established" component=discovery/localnet May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:00 volumio systemd[1]: mpd.service: Deactivated successfully. May 26 11:55:00 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. May 26 11:55:00 volumio sudo[16784]: pam_unix(sudo:session): session closed for user root May 26 11:55:00 volumio systemd[1]: mpd.socket: Deactivated successfully. May 26 11:55:00 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 26 11:55:00 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 26 11:55:00 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 26 11:55:00 volumio volumio[16353]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 26 11:55:00 volumio volumio[16353]: info: [1779807300376] CoreMusicLibrary::Adding element Last_100 May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 11:55:00 volumio systemd[1]: Starting mpd.service - Music Player Daemon... May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 26 11:55:00 volumio volumio[16353]: info: [1779807300380] CoreMusicLibrary::Adding element Webradio May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 11:55:00 volumio volumio[16353]: info: Initializing BBC Radios May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:00 volumio volumio[16353]: info: Creating Spotify config file May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:00 volumio volumio[16353]: info: gpio-buttons: Creating GPIO triggers... May 26 11:55:00 volumio volumio[16353]: info: Loading i18n strings for locale en May 26 11:55:00 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 11:55:00 volumio sudo[16803]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 26 11:55:00 volumio sudo[16803]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 26 11:55:00 volumio volumio[16353]: info: Volumio Calling Home May 26 11:55:00 volumio sudo[16803]: pam_unix(sudo:session): session closed for user root May 26 11:55:00 volumio sudo[16819]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge May 26 11:55:00 volumio sudo[16819]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:00 volumio sudo[16819]: pam_unix(sudo:session): session closed for user root May 26 11:55:00 volumio volumio[16353]: info: gpio-buttons: Started successfully May 26 11:55:00 volumio sudo[16828]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service May 26 11:55:00 volumio sudo[16828]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:00 volumio sudo[16832]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload May 26 11:55:00 volumio sudo[16832]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:00 volumio sudo[16830]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service May 26 11:55:00 volumio sudo[16830]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:00 volumio systemd[1]: Reloading. May 26 11:55:00 volumio volumio[16353]: info: touch_display: No backlight interface detected. May 26 11:55:01 volumio volumio[16353]: info: MPD Permissions set May 26 11:55:01 volumio volumio[16353]: info: MPD Permissions set May 26 11:55:01 volumio volumio[16353]: verbose: New Socket.io Connection to 192.168.15.26 from 192.168.15.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 6 May 26 11:55:01 volumio volumio[16353]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 26 11:55:01 volumio volumio[16353]: info: Volumio called home May 26 11:55:01 volumio volumio[16353]: info: Spotify config file written May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio sudo[16860]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service May 26 11:55:01 volumio sudo[16860]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:01 volumio sudo[16852]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/ May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:01 volumio sudo[16852]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:01 volumio sudo[16852]: pam_unix(sudo:session): session closed for user root May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::volumioGetVisibleSources May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:01 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:01 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 26 11:55:01 volumio volumio[16353]: info: Received Get System Info May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 11:55:01 volumio volumio[16353]: info: Discovery: Getting this device information May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:01 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:01 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:01 volumio volumio[16353]: info: Listing playlists May 26 11:55:01 volumio volumio[16353]: info: No need to fix Spotify hosts May 26 11:55:01 volumio volumio[16353]: info: touch_display: IframeKeyboardBridge extension installed successfully May 26 11:55:01 volumio volumio[16353]: info: touch_display: No Raspberry Pi Foundation touch screen detected. May 26 11:55:01 volumio sudo[16875]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf May 26 11:55:01 volumio sudo[16875]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:01 volumio sudo[16877]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf May 26 11:55:01 volumio sudo[16877]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:01 volumio sudo[16875]: pam_unix(sudo:session): session closed for user root May 26 11:55:01 volumio sudo[16877]: pam_unix(sudo:session): session closed for user root May 26 11:55:01 volumio volumio[16353]: info: Starting Shairport Sync May 26 11:55:01 volumio volumio[16353]: info: Starting Shairport Sync May 26 11:55:01 volumio volumio[16353]: info: Starting Shairport Sync May 26 11:55:01 volumio sudo[16881]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 26 11:55:01 volumio sudo[16881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:01 volumio sudo[16885]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 26 11:55:01 volumio sudo[16885]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:01 volumio sudo[16884]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 26 11:55:01 volumio volumio[16353]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. May 26 11:55:01 volumio volumio[16353]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. May 26 11:55:01 volumio sudo[16884]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:01 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:01 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:02 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:55:02 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:55:02 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:55:02 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:55:02 volumio sudo[16832]: pam_unix(sudo:session): session closed for user root May 26 11:55:02 volumio volumio[16353]: info: touch_display: systemctl daemon-reload succeeded. May 26 11:55:02 volumio systemd[1]: Reloading. May 26 11:55:02 volumio sudo[16890]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service May 26 11:55:02 volumio sudo[16890]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:03 volumio volumio[16353]: 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/148.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 May 26 11:55:03 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:55:03 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:55:03 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:55:03 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 26 11:55:03 volumio sudo[16830]: pam_unix(sudo:session): session closed for user root May 26 11:55:03 volumio volumio[16353]: info: touch_display: systemctl disable getty@tty1.service succeeded. May 26 11:55:03 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. May 26 11:55:03 volumio systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... May 26 11:55:03 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 26 11:55:03 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. May 26 11:55:03 volumio systemd[1]: upmpdcli.service: Consumed 1min 984ms CPU time. May 26 11:55:03 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 26 11:55:03 volumio sudo[16890]: pam_unix(sudo:session): session closed for user root May 26 11:55:03 volumio volumio[16353]: info: touch_display: systemctl start volumio-kiosk.service succeeded. May 26 11:55:03 volumio volumio[16353]: info: touch_display: Volumio Kiosk started. May 26 11:55:03 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:03 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:03 volumio systemd[1]: go-librespot-daemon.service: Deactivated successfully. May 26 11:55:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 26 11:55:03 volumio systemd[1]: go-librespot-daemon.service: Consumed 3.127s CPU time. May 26 11:55:03 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:03 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:03 volumio systemd[1]: shairport-sync.service: Deactivated successfully. May 26 11:55:03 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 26 11:55:03 volumio systemd[1]: shairport-sync.service: Consumed 4min 30.337s CPU time. May 26 11:55:03 volumio sudo[16828]: pam_unix(sudo:session): session closed for user root May 26 11:55:03 volumio volumio[16353]: info: touch_display: systemctl stop getty@tty1.service succeeded. May 26 11:55:03 volumio volumio[16353]: info: touch_display: X display number found: 0 May 26 11:55:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 26 11:55:04 volumio sudo[16860]: pam_unix(sudo:session): session closed for user root May 26 11:55:04 volumio go-librespot[16939]: go-librespot daemon starting... May 26 11:55:04 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 26 11:55:04 volumio sudo[16884]: pam_unix(sudo:session): session closed for user root May 26 11:55:04 volumio sudo[16881]: pam_unix(sudo:session): session closed for user root May 26 11:55:04 volumio sudo[16885]: pam_unix(sudo:session): session closed for user root May 26 11:55:04 volumio volumio[16353]: info: Shairport-Sync Started May 26 11:55:04 volumio volumio[16353]: Error adding Membership: Error: addMembership EINVAL May 26 11:55:04 volumio volumio[16353]: info: Shairport-Sync Started May 26 11:55:04 volumio volumio[16353]: info: Shairport-Sync Started May 26 11:55:04 volumio volumio[16353]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 26 11:55:04 volumio mpd[16825]: 2026-05-26T11:55:04 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 26 11:55:04 volumio sudo[16945]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 11:55:04 volumio sudo[16945]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:04 volumio sudo[16947]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 11:55:04 volumio sudo[16947]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:04 volumio sudo[16945]: pam_unix(sudo:session): session closed for user root May 26 11:55:04 volumio volumio[16353]: info: touch_display: X display number found: 0 May 26 11:55:04 volumio volumio[16353]: info: touch_display: X display number found: 0 May 26 11:55:04 volumio sudo[16947]: pam_unix(sudo:session): session closed for user root May 26 11:55:04 volumio volumio[16353]: info: touch_display: HDMI audio configuration missing from volumiokiosk.sh, restoring for HDMI-A-2 May 26 11:55:04 volumio sudo[16978]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 26 11:55:04 volumio sudo[16978]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:04 volumio volumio[16353]: info: touch_display: Found 1 active display(s). May 26 11:55:04 volumio volumio[16353]: info: touch_display: Setting screensaver timeout to 0 seconds. May 26 11:55:04 volumio sudo[16978]: pam_unix(sudo:session): session closed for user root May 26 11:55:04 volumio volumio[16353]: info: Upmpdcli Daemon Started May 26 11:55:04 volumio systemd[1]: Started mpd.service - Music Player Daemon. May 26 11:55:04 volumio sudo[16776]: pam_unix(sudo:session): session closed for user root May 26 11:55:04 volumio go-librespot[16941]: time="2026-05-26T11:55:04-03:00" level=info msg="running go-librespot 0.7.1" May 26 11:55:04 volumio go-librespot[16941]: time="2026-05-26T11:55:04-03:00" level=debug msg="app state loaded" May 26 11:55:04 volumio go-librespot[16941]: time="2026-05-26T11:55:04-03:00" level=debug msg="stored credentials not found" May 26 11:55:04 volumio sudo[16790]: pam_unix(sudo:session): session closed for user root May 26 11:55:04 volumio go-librespot[16941]: time="2026-05-26T11:55:04-03:00" level=info msg="api server listening on 127.0.0.1:9879" May 26 11:55:04 volumio volumio[16353]: info: Completed starting Core Plugins May 26 11:55:04 volumio volumio[16353]: info: ------------------------------------------- May 26 11:55:04 volumio volumio[16353]: info: ----- MyVolumio plugins startup ---- May 26 11:55:04 volumio volumio[16353]: info: ------------------------------------------- May 26 11:55:04 volumio volumio[16353]: info: [MyVolumio PluginManager] Fetching plans data.... May 26 11:55:04 volumio volumio[16353]: info: touch_display: No touch devices detected. May 26 11:55:04 volumio volumio[16353]: info: touch_display: No touch devices found, skipping touch calibration. May 26 11:55:04 volumio sudo[17009]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/sed -i '/# HDMI_AUDIO_KEEPALIVE/d' /opt/volumiokiosk.sh May 26 11:55:04 volumio sudo[17009]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:04 volumio sudo[17009]: pam_unix(sudo:session): session closed for user root May 26 11:55:04 volumio volumio[16353]: error: MPD error: The expression evaluated to a falsy value: May 26 11:55:04 volumio volumio[16353]: assert.ok(self.idling) May 26 11:55:04 volumio volumio[16353]: error: The expression evaluated to a falsy value: May 26 11:55:04 volumio volumio[16353]: assert.ok(self.idling) May 26 11:55:04 volumio volumio[16353]: error: updateQueue error: null May 26 11:55:04 volumio volumio[16353]: info: MPD running with PID16825 May 26 11:55:04 volumio volumio[16353]: ,establishing connection May 26 11:55:04 volumio volumio[16353]: error: updateQueue error: null May 26 11:55:04 volumio sudo[17014]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/sed -i '/\\/usr\\/bin\\/chromium-browser/i export DISPLAY=:0 # HDMI_AUDIO_KEEPALIVE\\ntimeout 5 bash -c \'until xrandr >/dev/null 2>&1; do sleep 0.5; done\' # HDMI_AUDIO_KEEPALIVE\\nxrandr --output HDMI-1 --mode 1024x768 --primary --pos 0x0 # HDMI_AUDIO_KEEPALIVE\\nxrandr --output HDMI-A-2 --mode 1920x1080 --pos 1024x0 # HDMI_AUDIO_KEEPALIVE\\nsleep 1 # HDMI_AUDIO_KEEPALIVE' /opt/volumiokiosk.sh May 26 11:55:04 volumio sudo[17014]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:04 volumio sudo[17014]: pam_unix(sudo:session): session closed for user root May 26 11:55:04 volumio volumio[16353]: info: touch_display: HDMI audio keep-alive commands inserted into volumiokiosk.sh for HDMI-A-2 May 26 11:55:04 volumio sudo[17020]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-kiosk.service May 26 11:55:04 volumio sudo[17020]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:04 volumio systemd[1]: Stopping volumio-kiosk.service - Volumio Kiosk... May 26 11:55:04 volumio startx[16262]: xinit: connection to X server lost May 26 11:55:04 volumio startx[16262]: May 26 11:55:04 volumio upmpdcli[17019]: writing RSA key May 26 11:55:04 volumio go-librespot[16941]: time="2026-05-26T11:55:04-03:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" May 26 11:55:04 volumio go-librespot[16941]: time="2026-05-26T11:55:04-03:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" May 26 11:55:04 volumio go-librespot[16941]: time="2026-05-26T11:55:04-03:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" May 26 11:55:04 volumio go-librespot[16941]: time="2026-05-26T11:55:04-03:00" level=info msg="zeroconf server listening on port 36801" May 26 11:55:04 volumio go-librespot[16941]: time="2026-05-26T11:55:04-03:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" May 26 11:55:05 volumio startx[16262]: waiting for X server to shut down May 26 11:55:05 volumio startx[16264]: (II) Server terminated successfully (0). Closing log file. May 26 11:55:05 volumio startx[16262]: xinit: unexpected signal 15 May 26 11:55:05 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE May 26 11:55:05 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. May 26 11:55:05 volumio systemd[1]: Stopped volumio-kiosk.service - Volumio Kiosk. May 26 11:55:05 volumio systemd[1]: volumio-kiosk.service: Consumed 13.504s CPU time. May 26 11:55:05 volumio systemd[1]: Started volumio-kiosk.service - Volumio Kiosk. May 26 11:55:06 volumio sudo[17020]: pam_unix(sudo:session): session closed for user root May 26 11:55:06 volumio volumio[16353]: info: touch_display: systemctl restart volumio-kiosk.service succeeded. May 26 11:55:06 volumio volumio[16353]: info: touch_display: Volumio Kiosk restarted. May 26 11:55:06 volumio volumio-remote-updater[831]: [2026-05-26 11:55:06] [connect] Successful connection May 26 11:55:06 volumio volumio-remote-updater[831]: [2026-05-26 11:55:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1779807306 101 May 26 11:55:06 volumio volumio[16353]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 9 May 26 11:55:06 volumio volumio[16353]: info: touch_display: X display number found: May 26 11:55:06 volumio startx[17055]: X.Org X Server 1.21.1.7 May 26 11:55:06 volumio startx[17055]: X Protocol Version 11, Revision 0 May 26 11:55:06 volumio startx[17055]: Current Operating System: Linux volumio 6.12.74-v7l+ #1948 SMP Mon Mar 2 11:27:49 GMT 2026 armv7l May 26 11:55:06 volumio startx[17055]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave nvme.max_host_mem_size_mb=0 snd_bcm2835.enable_hdmi=0 video=HDMI-A-1:640x480M@60D numa=fake=2 system_heap.max_order=0 iommu_dma_numa_policy=interleave smsc95xx.macaddr=D8:3A:DD:3C:96:7F vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=9caf6474-168f-4972-add4-ace36a467bc2 imgfile=/volumio_current.sqsh bootpart=UUID=807D-2966 datapart=UUID=bea3e05c-62cf-4b22-a58d-66213927f56a uuidconfig=cmdline.txt rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no May 26 11:55:06 volumio startx[17055]: xorg-server 2:21.1.7-3+rpt3+deb12u11 (https://www.debian.org/support) May 26 11:55:06 volumio startx[17055]: Current version of pixman: 0.44.0 May 26 11:55:06 volumio startx[17055]: Before reporting problems, check http://wiki.x.org May 26 11:55:06 volumio startx[17055]: to make sure that you have the latest version. May 26 11:55:06 volumio startx[17055]: Markers: (--) probed, (**) from config file, (==) default setting, May 26 11:55:06 volumio startx[17055]: (++) from command line, (!!) notice, (II) informational, May 26 11:55:06 volumio startx[17055]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. May 26 11:55:06 volumio startx[17055]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue May 26 11:55:06 2026 May 26 11:55:06 volumio startx[17055]: (==) Using config directory: "/etc/X11/xorg.conf.d" May 26 11:55:06 volumio startx[17055]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" May 26 11:55:06 volumio volumio[16353]: info: touch_display: X display number found: 0 May 26 11:55:06 volumio volumio[16353]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 26 11:55:06 volumio volumio[16353]: info: touch_display: HDMI audio configuration already present in volumiokiosk.sh May 26 11:55:06 volumio volumio[16353]: info: touch_display: X display number found: 0 May 26 11:55:06 volumio volumio[16353]: info: Enabling plugin peppymeterbasic May 26 11:55:06 volumio volumio[16353]: info: Loading plugin "peppymeterbasic"... May 26 11:55:06 volumio volumio[16353]: info: Preparing to generate the ALSA configuration file May 26 11:55:06 volumio volumio[16353]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 26 11:55:06 volumio volumio[16353]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf May 26 11:55:06 volumio volumio[16353]: info: Reading ALSA contributions from plugins. May 26 11:55:06 volumio volumio[16353]: info: Asound.conf file written May 26 11:55:06 volumio sudo[17066]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 26 11:55:06 volumio sudo[17066]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:06 volumio sudo[17066]: pam_unix(sudo:session): session closed for user root May 26 11:55:06 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 May 26 11:55:06 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 May 26 11:55:06 volumio volumio[16353]: /usr/share/alsa/init/bcm2835:14: control element not found May 26 11:55:06 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 May 26 11:55:06 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 May 26 11:55:06 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 May 26 11:55:06 volumio volumio[16353]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:85dd" "" "" May 26 11:55:06 volumio volumio[16353]: Hardware is initialized using a generic method May 26 11:55:06 volumio volumio[16353]: info: Output device has changed, restarting MPD May 26 11:55:06 volumio volumio[16353]: info: Output device has changed, restarting Shairport Sync May 26 11:55:06 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:07 volumio sudo[17073]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 26 11:55:07 volumio sudo[17073]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:07 volumio sudo[17073]: pam_unix(sudo:session): session closed for user root May 26 11:55:07 volumio sudo[17075]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 26 11:55:07 volumio sudo[17075]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:07 volumio volumio[16353]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 26 11:55:07 volumio volumio[16353]: info: PLUGIN START: peppymeterbasic May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 26 11:55:07 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... May 26 11:55:07 volumio volumio[16353]: info: Preparing to generate the ALSA configuration file May 26 11:55:07 volumio sudo[17083]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 May 26 11:55:07 volumio sudo[17083]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:07 volumio volumio[16353]: info: Done. May 26 11:55:07 volumio volumio[16353]: info: go-librespot daemon successfully initialized May 26 11:55:07 volumio volumio[16353]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 26 11:55:07 volumio volumio[16353]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf May 26 11:55:07 volumio volumio[16353]: info: Reading ALSA contributions from plugins. May 26 11:55:07 volumio sudo[17083]: pam_unix(sudo:session): session closed for user root May 26 11:55:07 volumio volumio[16353]: info: MPD Permissions set May 26 11:55:07 volumio volumio[16353]: info: snd_dummy loaded May 26 11:55:07 volumio volumio[16353]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio (udev-worker)[17100]: controlC7: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 7' failed with exit code 99. May 26 11:55:07 volumio volumio[16353]: info: Starting Shairport Sync May 26 11:55:07 volumio volumio[16353]: info: touch_display: Setting screensaver timeout to 0 seconds. May 26 11:55:07 volumio volumio[16353]: info: Asound.conf file unchanged, so no further update is needed May 26 11:55:07 volumio volumio[16353]: info: Output device has changed, restarting MPD May 26 11:55:07 volumio sudo[17125]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 26 11:55:07 volumio sudo[17125]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:07 volumio volumio[16353]: info: Output device has changed, restarting Shairport Sync May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:07 volumio sudo[17132]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 26 11:55:07 volumio sudo[17132]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:07 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 26 11:55:07 volumio volumio[16353]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 26 11:55:07 volumio systemd[1]: shairport-sync.service: Deactivated successfully. May 26 11:55:07 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 26 11:55:07 volumio systemd[1]: shairport-sync.service: Consumed 1.460s CPU time. May 26 11:55:07 volumio sudo[17135]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 26 11:55:07 volumio sudo[17135]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:07 volumio sudo[17132]: pam_unix(sudo:session): session closed for user root May 26 11:55:07 volumio volumio[16353]: info: MPD Permissions set May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio sudo[17125]: pam_unix(sudo:session): session closed for user root May 26 11:55:07 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 26 11:55:07 volumio systemd[1]: mpd.service: Deactivated successfully. May 26 11:55:07 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. May 26 11:55:07 volumio systemd[1]: mpd.service: Consumed 3.123s CPU time. May 26 11:55:07 volumio systemd[1]: mpd.socket: Deactivated successfully. May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:07 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 26 11:55:07 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 26 11:55:07 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 26 11:55:07 volumio volumio[16353]: info: Shairport-Sync Started May 26 11:55:07 volumio systemd[1]: Starting mpd.service - Music Player Daemon... May 26 11:55:07 volumio volumio[16353]: info: Starting Shairport Sync May 26 11:55:07 volumio systemd[1]: mpd.service: Deactivated successfully. May 26 11:55:07 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. May 26 11:55:07 volumio systemd[1]: mpd.socket: Deactivated successfully. May 26 11:55:07 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 26 11:55:07 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 26 11:55:07 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 26 11:55:07 volumio systemd[1]: Starting mpd.service - Music Player Daemon... May 26 11:55:07 volumio sudo[17185]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 26 11:55:07 volumio sudo[17185]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:07 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 26 11:55:07 volumio systemd[1]: shairport-sync.service: Deactivated successfully. May 26 11:55:07 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 26 11:55:07 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 26 11:55:07 volumio sudo[17185]: pam_unix(sudo:session): session closed for user root May 26 11:55:07 volumio volumio[16353]: info: Shairport-Sync Started May 26 11:55:07 volumio sudo[17187]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 26 11:55:07 volumio sudo[17187]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 26 11:55:07 volumio sudo[17187]: pam_unix(sudo:session): session closed for user root May 26 11:55:07 volumio volumio[16353]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 11:55:09 volumio mpd[17209]: 2026-05-26T11:55:08 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 26 11:55:09 volumio systemd[1]: Started mpd.service - Music Player Daemon. May 26 11:55:09 volumio sudo[17075]: pam_unix(sudo:session): session closed for user root May 26 11:55:09 volumio sudo[17135]: pam_unix(sudo:session): session closed for user root May 26 11:55:09 volumio volumio[16353]: error: MPD error: The expression evaluated to a falsy value: May 26 11:55:09 volumio volumio[16353]: assert.ok(self.idling) May 26 11:55:09 volumio volumio[16353]: error: The expression evaluated to a falsy value: May 26 11:55:09 volumio volumio[16353]: assert.ok(self.idling) May 26 11:55:09 volumio volumio[16353]: error: updateQueue error: null May 26 11:55:10 volumio volumio[16353]: info: Initializing connection to go-librespot Websocket May 26 11:55:10 volumio go-librespot[16941]: time="2026-05-26T11:55:10-03:00" level=debug msg="new websocket client" May 26 11:55:10 volumio volumio[16353]: info: Connection to go-librespot Websocket established May 26 11:55:13 volumio volumio[16353]: info: Getting Spotify volume May 26 11:55:13 volumio volumio[16353]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 May 26 11:55:15 volumio volumio[16353]: Cannot compose Albumart path May 26 11:55:16 volumio volumio[16353]: 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/148.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 May 26 11:55:16 volumio volumio[16353]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] May 26 11:55:16 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy May 26 11:55:16 volumio volumio[16353]: aaaaaaaaaaa 1280,400 May 26 11:55:16 volumio volumio[16353]: info: PeppyMeterBasic ---1280400 May 26 11:55:16 volumio volumio[16353]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') May 26 11:55:16 volumio volumio[16353]: 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/148.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 May 26 11:55:16 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:16 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:16 volumio volumio[16353]: SPOTIFY: RECEIVED VOLUMIO VOLUME 0 May 26 11:55:16 volumio volumio[16353]: SPOTIFY: SPOTIFY VOLUME undefined May 26 11:55:16 volumio volumio[16353]: SPOTIFY: VOLUMIO VOLUME 0 May 26 11:55:16 volumio volumio[16353]: info: Aligning Spotify Volume to Volumio Volume May 26 11:55:16 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:16 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:16 volumio volumio[16353]: info: Setting Spotify Volume from Volumio: 0 May 26 11:55:16 volumio volumio[16353]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 11:55:16 volumio volumio[16353]: info: CoreCommandRouter::Close All Modals sent May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 26 11:55:17 volumio volumio[16353]: info: Adding plugin bluetooth to MyMusic Plugins May 26 11:55:17 volumio volumio[16353]: info: Adding plugin multiroom to MyMusic Plugins May 26 11:55:17 volumio volumio[16353]: info: Adding plugin metavolumio to MyMusic Plugins May 26 11:55:17 volumio volumio[16353]: info: Adding plugin cd_controller to MyMusic Plugins May 26 11:55:17 volumio volumio[16353]: info: Adding plugin qobuzconnect to MyMusic Plugins May 26 11:55:17 volumio volumio[16353]: info: Adding plugin smart_inputs to MyMusic Plugins May 26 11:55:17 volumio volumio[16353]: info: Adding plugin tidalconnect to MyMusic Plugins May 26 11:55:17 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 26 11:55:18 volumio volumio[16353]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 26 11:55:18 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 26 11:55:18 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:18 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:18 volumio volumio[16353]: info: Starting MyVolumio Remote Streaming Endpoints May 26 11:55:18 volumio volumio[16353]: info: MyVolumio login type: Token May 26 11:55:18 volumio volumio[16353]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 26 11:55:18 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 26 11:55:19 volumio volumio[16353]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 26 11:55:19 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 26 11:55:19 volumio volumio[16353]: info: Streaming services startup May 26 11:55:19 volumio volumio[16353]: info: Starting Streaming Daemon May 26 11:55:19 volumio sudo[17356]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 26 11:55:19 volumio sudo[17356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:19 volumio volumio[16353]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 26 11:55:19 volumio volumio[16353]: SPOTIFY: SETTING SPOTIFY VOLUME 0 May 26 11:55:19 volumio volumio[16353]: info: Sending Spotify command with payload to local API: /player/volume May 26 11:55:19 volumio volumio[16353]: 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/148.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 May 26 11:55:19 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... May 26 11:55:19 volumio sudo[17356]: pam_unix(sudo:session): session closed for user root May 26 11:55:19 volumio volumio[16353]: error: Cannot start Volumio Streaming Daemon May 26 11:55:19 volumio volumio[16353]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 26 11:55:19 volumio volumio[16353]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 26 11:55:19 volumio volumio[16353]: error: MyVolumio Custom Token format not valid, refreshing it May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::volumioGetVisibleSources May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:19 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 26 11:55:19 volumio volumio[16353]: info: Received Get System Info May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 11:55:19 volumio volumio[16353]: info: Discovery: Getting this device information May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:19 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:19 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:19 volumio volumio[16353]: info: Listing playlists May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 11:55:19 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 26 11:55:19 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. May 26 11:55:19 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. May 26 11:55:20 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:20 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:20 volumio volumio[16353]: info: MyVolumio login type: Token May 26 11:55:21 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 11:55:21 volumio volumio[16353]: info: Received Get System Info May 26 11:55:21 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 11:55:21 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 11:55:21 volumio volumio[16353]: info: Discovery: Getting this device information May 26 11:55:21 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:21 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:21 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 11:55:21 volumio volumio[16353]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN May 26 11:55:21 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 26 11:55:21 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 26 11:55:21 volumio volumio[16353]: info: MyVolumio login type: Token May 26 11:55:21 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 11:55:21 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 26 11:55:22 volumio volumio[16353]: info: MyVolumio token set successfully May 26 11:55:22 volumio volumio[16353]: info: MYVOLUMIO: Adding device May 26 11:55:22 volumio volumio[16353]: info: MYVOLUMIO: Evaluating Server May 26 11:55:22 volumio volumio[16353]: info: MyVolumio Plan changed: premium May 26 11:55:22 volumio volumio[16353]: info: [MyVolumio PluginManager] Subscribed plan changed to premium May 26 11:55:22 volumio volumio[16353]: info: Removing browser output: myVolumio user plan is not superstar May 26 11:55:22 volumio volumio[16353]: info: Removing audio output: May 26 11:55:22 volumio volumio[16353]: info: MYVOLUMIO: Adding device May 26 11:55:22 volumio volumio[16353]: info: MYVOLUMIO: Evaluating Server May 26 11:55:22 volumio volumio[16353]: info: Remote config written successfully May 26 11:55:22 volumio volumio[16353]: info: Starting Tunnel 1 May 26 11:55:22 volumio volumio[16353]: info: Starting Tunnel Connection Checker May 26 11:55:22 volumio volumio[16353]: info: Completed starting MyVolumio Plugin May 26 11:55:22 volumio volumio[16353]: info: MYVolumio Device enabled May 26 11:55:22 volumio volumio[16353]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... May 26 11:55:22 volumio volumio[16353]: info: MyVolumio status changed May 26 11:55:22 volumio volumio[16353]: info: Streaming services startup May 26 11:55:22 volumio volumio[16353]: info: Starting Streaming Daemon May 26 11:55:22 volumio sudo[17427]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 26 11:55:22 volumio sudo[17427]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:22 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid May 26 11:55:22 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... May 26 11:55:22 volumio sudo[17427]: pam_unix(sudo:session): session closed for user root May 26 11:55:22 volumio volumio[16353]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth May 26 11:55:22 volumio volumio[16353]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth May 26 11:55:22 volumio volumio[16353]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart May 26 11:55:22 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... May 26 11:55:23 volumio volumio5-onboarding[1542]: time=2026-05-26T11:55:23.136-03:00 level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=ezQf6rzBaxNXDt6VkOMxFhTegCI3 tokenExpiry=2026-05-26T12:55:23.136-03:00 May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom May 26 11:55:24 volumio sudo[17445]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom May 26 11:55:24 volumio sudo[17445]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:24 volumio sudo[17445]: pam_unix(sudo:session): session closed for user root May 26 11:55:24 volumio volumio[16353]: /usr/bin/mkdir: cannot create directory ‘/tmp/hls’: File exists May 26 11:55:24 volumio volumio[16353]: info: MRS: MultiRoom plugin initialized May 26 11:55:24 volumio volumio[16353]: info: MRS: STOPPING SNAPCLIENT May 26 11:55:24 volumio volumio[16353]: info: MRS: Snap server stop May 26 11:55:24 volumio volumio[16353]: info: MRS: STOPPING volumioStreaming May 26 11:55:24 volumio sudo[17462]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient May 26 11:55:24 volumio sudo[17462]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:24 volumio sudo[17464]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver May 26 11:55:24 volumio sudo[17464]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... May 26 11:55:24 volumio sudo[17466]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming May 26 11:55:24 volumio sudo[17466]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:24 volumio sudo[17469]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* May 26 11:55:24 volumio sudo[17469]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:24 volumio sudo[17469]: pam_unix(sudo:session): session closed for user root May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... May 26 11:55:24 volumio sudo[17462]: pam_unix(sudo:session): session closed for user root May 26 11:55:24 volumio sudo[17466]: pam_unix(sudo:session): session closed for user root May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... May 26 11:55:24 volumio sudo[17464]: pam_unix(sudo:session): session closed for user root May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "tidal"... May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... May 26 11:55:24 volumio volumio[16353]: info: Preparing to generate the ALSA configuration file May 26 11:55:24 volumio volumio[16353]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 26 11:55:24 volumio volumio[16353]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 26 11:55:24 volumio volumio[16353]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf May 26 11:55:24 volumio volumio[16353]: info: Reading ALSA contributions from plugins. May 26 11:55:24 volumio volumio[16353]: info: Setting Geolocation for MyVolumio to us1 May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:24 volumio volumio[16353]: info: Setting Geolocation for MyVolumio to us1 May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 11:55:24 volumio volumio[16353]: info: Received Get System Info May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 11:55:24 volumio volumio[16353]: info: Discovery: Getting this device information May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:24 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 11:55:24 volumio volumio[16353]: info: Received Get System Info May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 11:55:24 volumio volumio[16353]: info: Discovery: Getting this device information May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:24 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 11:55:24 volumio volumio[16353]: info: MRS: Removed streaming files May 26 11:55:24 volumio volumio[16353]: info: MRS: volumioStreaming STOPPED May 26 11:55:24 volumio volumio[16353]: info: MRS: SNAPSERVER STOPPED May 26 11:55:24 volumio volumio[16353]: info: MRS: SNAPCLIENT STOPPED May 26 11:55:24 volumio volumio[16353]: error: Cannot start Volumio Streaming Daemon May 26 11:55:24 volumio volumio[16353]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 26 11:55:24 volumio volumio[16353]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 26 11:55:24 volumio volumio[16353]: info: Asound.conf file written May 26 11:55:24 volumio sudo[17477]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 26 11:55:24 volumio sudo[17477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:24 volumio sudo[17477]: pam_unix(sudo:session): session closed for user root May 26 11:55:24 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 May 26 11:55:24 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 May 26 11:55:24 volumio volumio[16353]: /usr/share/alsa/init/bcm2835:14: control element not found May 26 11:55:24 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 May 26 11:55:24 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 May 26 11:55:24 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 May 26 11:55:24 volumio volumio[16353]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:85dd" "" "" May 26 11:55:24 volumio volumio[16353]: Hardware is initialized using a generic method May 26 11:55:24 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 May 26 11:55:24 volumio volumio[16353]: No state is present for card Loopback May 26 11:55:24 volumio volumio[16353]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 May 26 11:55:24 volumio volumio[16353]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" May 26 11:55:24 volumio volumio[16353]: Hardware is initialized using a generic method May 26 11:55:24 volumio volumio[16353]: No state is present for card Loopback May 26 11:55:24 volumio volumio[16353]: info: Output device has changed, restarting MPD May 26 11:55:24 volumio volumio[16353]: info: Output device has changed, restarting Shairport Sync May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:24 volumio sudo[17486]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 26 11:55:24 volumio volumio[16353]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 26 11:55:24 volumio sudo[17484]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 26 11:55:24 volumio volumio[16353]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 26 11:55:24 volumio sudo[17484]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:24 volumio sudo[17486]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:24 volumio sudo[17486]: pam_unix(sudo:session): session closed for user root May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth May 26 11:55:24 volumio volumio[16353]: ------------------------------------ BT MESSAGE: [FUNC] onStart May 26 11:55:24 volumio volumio[16353]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service May 26 11:55:24 volumio volumio[16353]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp May 26 11:55:24 volumio volumio[16353]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus May 26 11:55:24 volumio volumio[16353]: info: MRS: Pushing multiroomSync output for this device May 26 11:55:24 volumio volumio[16353]: info: MRS: Pushing multiroomSync output May 26 11:55:24 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... May 26 11:55:24 volumio volumio[16353]: info: Adding audio output: May 26 11:55:24 volumio volumio[16353]: info: Adding audio output: May 26 11:55:24 volumio volumio[16353]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:24 volumio bluetoothd[883]: Path / reserved for Adv Monitor app :1.127 May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio May 26 11:55:24 volumio volumio[16353]: info: Adding METAVOLUMIO REST API Endpoints May 26 11:55:24 volumio volumio[16353]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio May 26 11:55:24 volumio volumio[16353]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio May 26 11:55:24 volumio volumio[16353]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio May 26 11:55:24 volumio volumio[16353]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui May 26 11:55:24 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller May 26 11:55:24 volumio volumio[16353]: info: Preparing CD Folders May 26 11:55:24 volumio volumio[16353]: info: Adding CD REST API Endpoints May 26 11:55:24 volumio volumio[16353]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller May 26 11:55:24 volumio volumio[16353]: info: Starting UDEV Watcher for CD May 26 11:55:24 volumio volumio[16353]: info: Detecting CD presence with UDEV May 26 11:55:24 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices May 26 11:55:24 volumio bluetoothd[883]: Adv Monitor app :1.127 disconnected from D-Bus May 26 11:55:24 volumio systemd[1]: mpd.service: Deactivated successfully. May 26 11:55:24 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. May 26 11:55:24 volumio systemd[1]: mpd.service: Consumed 2.464s CPU time. May 26 11:55:24 volumio systemd[1]: mpd.socket: Deactivated successfully. May 26 11:55:24 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 26 11:55:24 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 26 11:55:24 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 26 11:55:24 volumio systemd[1]: Starting mpd.service - Music Player Daemon... May 26 11:55:24 volumio sudo[17503]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 26 11:55:24 volumio sudo[17503]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 26 11:55:24 volumio sudo[17503]: pam_unix(sudo:session): session closed for user root May 26 11:55:26 volumio mpd[17505]: 2026-05-26T11:55:26 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 26 11:55:26 volumio systemd[1]: Started mpd.service - Music Player Daemon. May 26 11:55:26 volumio sudo[17484]: pam_unix(sudo:session): session closed for user root May 26 11:55:29 volumio volumio[16353]: warn: [cd-plugin] cdspeedctl: device or media not ready May 26 11:55:29 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs May 26 11:55:29 volumio volumio[16353]: info: Adding inputs REST Endpoints May 26 11:55:29 volumio volumio[16353]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs May 26 11:55:29 volumio volumio[16353]: info: Scanning Audio Inputs May 26 11:55:29 volumio volumio[16353]: info: Checking against Known Cards name May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 26 11:55:29 volumio volumio[16353]: info: [1779807329818] CoreMusicLibrary::Adding element Loopback May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 11:55:29 volumio volumio[16353]: Cannot find translation for source Loopback May 26 11:55:29 volumio volumio[16353]: info: Checking against Known Cards name May 26 11:55:29 volumio volumio[16353]: info: Checking against Known Cards name May 26 11:55:29 volumio volumio[16353]: info: Adding Server instance for streaming May 26 11:55:29 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio May 26 11:55:29 volumio volumio[16353]: error: Hi Res Audio Failed Login: Missing Login Data May 26 11:55:29 volumio volumio[16353]: info: Adding HIGHRESAUDIO REST API Endpoints May 26 11:55:29 volumio volumio[16353]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio May 26 11:55:29 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal May 26 11:55:29 volumio volumio[16353]: info: Refreshing TIDAL token May 26 11:55:29 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz May 26 11:55:29 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect May 26 11:55:29 volumio volumio[16353]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect May 26 11:55:29 volumio volumio[16353]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect May 26 11:55:29 volumio sudo[17512]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 26 11:55:29 volumio volumio[16353]: info: QobuzConnect: Starting Qobuz Connect socket and service May 26 11:55:29 volumio sudo[17512]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:29 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... May 26 11:55:29 volumio systemd[1]: vtcs.service: Killing process 5515 (vtcs) with signal SIGKILL. May 26 11:55:29 volumio systemd[1]: vtcs.service: Deactivated successfully. May 26 11:55:29 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. May 26 11:55:29 volumio systemd[1]: vtcs.service: Consumed 27.078s CPU time. May 26 11:55:29 volumio sudo[17519]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 26 11:55:29 volumio volumio[16353]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections May 26 11:55:29 volumio sudo[17519]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:29 volumio volumio[16353]: info: Stopping AccessToken refresher cron for QOBUZ May 26 11:55:29 volumio sudo[17512]: pam_unix(sudo:session): session closed for user root May 26 11:55:29 volumio sudo[17519]: pam_unix(sudo:session): session closed for user root May 26 11:55:29 volumio volumio[16353]: info: AccessToken refresher cron started for QOBUZ May 26 11:55:29 volumio volumio[16353]: info: Adding QOBUZ REST API Endpoints May 26 11:55:29 volumio volumio[16353]: info: MRS: Getting audio outputs on start May 26 11:55:29 volumio volumio[16353]: info: MRS: Requesting all other devices output May 26 11:55:29 volumio sudo[17522]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 26 11:55:29 volumio sudo[17522]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:29 volumio volumio[16353]: info: Updating MyVolumio device info May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:29 volumio volumio[16353]: info: Updating MyVolumio device info May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 11:55:29 volumio volumio[16353]: info: Received Get System Info May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 11:55:29 volumio volumio[16353]: info: Discovery: Getting this device information May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:29 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 11:55:29 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 26 11:55:29 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... May 26 11:55:30 volumio volumio[16353]: info: Successfully Added MyVolumio device May 26 11:55:30 volumio volumio[16353]: info: Successfully Added MyVolumio device May 26 11:55:30 volumio volumio[16353]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered on May 26 11:55:30 volumio qobuz-connect[5485]: 20260526 11:55:30.041 [5485.5485] INFO SampleApp: Stopping Local configuration server May 26 11:55:30 volumio volumio[16353]: info: MPD Permissions set May 26 11:55:30 volumio sudo[17526]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service May 26 11:55:30 volumio sudo[17526]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:30 volumio volumio[16353]: error: updateQueue error: null May 26 11:55:30 volumio sudo[17526]: pam_unix(sudo:session): session closed for user root May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:30 volumio volumio[16353]: info: MRS: Found cast device: Chromecast-Audio-abaf694705d16326f39eb6eb1e91cdbe May 26 11:55:30 volumio volumio[16353]: info: Adding audio output: May 26 11:55:30 volumio volumio[16353]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully May 26 11:55:30 volumio volumio[16353]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart May 26 11:55:30 volumio volumio[16353]: info: Starting Shairport Sync May 26 11:55:30 volumio sudo[17541]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 26 11:55:30 volumio sudo[17541]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:30 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 26 11:55:30 volumio systemd[1]: shairport-sync.service: Deactivated successfully. May 26 11:55:30 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 26 11:55:30 volumio systemd[1]: shairport-sync.service: Consumed 1.714s CPU time. May 26 11:55:30 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 26 11:55:30 volumio sudo[17541]: pam_unix(sudo:session): session closed for user root May 26 11:55:30 volumio volumio[16353]: info: Successfully Updated MyVolumio device May 26 11:55:30 volumio volumio[16353]: info: Successfully Updated MyVolumio device May 26 11:55:30 volumio sudo[17545]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service May 26 11:55:30 volumio volumio[16353]: info: Shairport-Sync Started May 26 11:55:30 volumio sudo[17545]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:30 volumio autossh[2297]: received signal to exit (15) May 26 11:55:30 volumio systemd[1]: Stopping sshtunnel.service - MyVolumio SSH Tunnel... May 26 11:55:30 volumio systemd[1]: sshtunnel.service: Deactivated successfully. May 26 11:55:30 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. May 26 11:55:30 volumio systemd[1]: sshtunnel.service: Consumed 4.173s CPU time. May 26 11:55:30 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. May 26 11:55:30 volumio sudo[17545]: pam_unix(sudo:session): session closed for user root May 26 11:55:30 volumio volumio[16353]: info: Remote SSH Started May 26 11:55:30 volumio autossh[17562]: port set to 0, monitoring disabled May 26 11:55:30 volumio autossh[17562]: starting ssh (count 1) May 26 11:55:30 volumio autossh[17562]: ssh child pid is 17565 May 26 11:55:30 volumio volumio[16353]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 26 11:55:30 volumio volumio-remote-updater[831]: Test mode disabled May 26 11:55:30 volumio volumio-remote-updater[831]: Alpha mode disabled May 26 11:55:30 volumio volumio-remote-updater[831]: Alpha legacy test mode disabled May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 26 11:55:30 volumio volumio[16353]: info: Access Token successfully retrieved May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:30 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:30 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. May 26 11:55:30 volumio volumio[16353]: info: Successfully retrieved User Session From TIDAL May 26 11:55:30 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. May 26 11:55:30 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. May 26 11:55:30 volumio sudo[17522]: pam_unix(sudo:session): session closed for user root May 26 11:55:30 volumio volumio[16353]: info: Executing endpoint qc_getconfig May 26 11:55:30 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 26 11:55:30 volumio qobuz-connect[17570]: 20260526 11:55:30.988 [17570.17570] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 26 11:55:30 volumio volumio[16353]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 26 11:55:30 volumio volumio[16353]: info: QobuzConnect: QOBUZ Connect daemon connected May 26 11:55:31 volumio qobuz-connect[17570]: 20260526 11:55:31.002 [17570.17570] INFO VolumeManager: [0x5c1d48]: Setting new playback volume: 75 May 26 11:55:31 volumio qobuz-connect[17570]: 20260526 11:55:31.002 [17570.17570] INFO VolumeManager: [0x5c1d48]: Setting new mute state: 0 May 26 11:55:31 volumio qobuz-connect[17570]: 20260526 11:55:31.002 [17570.17570] INFO AudioStreamManager: [0x5c1aa0]: Setting new audio download buffer size: 1048576 May 26 11:55:31 volumio qobuz-connect[17570]: 20260526 11:55:31.002 [17570.17570] INFO QobuzConnect: [0x5c2610]: Client initialized! May 26 11:55:31 volumio qobuz-connect[17570]: 20260526 11:55:31.002 [17570.17570] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp May 26 11:55:31 volumio qobuz-connect[17570]: 20260526 11:55:31.011 [17570.17570] INFO LocalConfigManager: [0x5c17c8]: Starting Local Configuration server May 26 11:55:31 volumio qobuz-connect[17570]: 20260526 11:55:31.011 [17570.17570] INFO SampleApp: Starting Local configuration server May 26 11:55:31 volumio qobuz-connect[17570]: 20260526 11:55:31.012 [17570.17570] INFO SampleApp: Connected to UNIX socket client 0x5ac818 May 26 11:55:31 volumio volumio[16353]: info: Successfully retrieved User Subscription From TIDAL May 26 11:55:31 volumio volumio[16353]: info: Adding TIDAL to Browse Sources May 26 11:55:31 volumio volumio[16353]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 26 11:55:31 volumio volumio[16353]: info: [1779807331032] CoreMusicLibrary::Adding element TIDAL May 26 11:55:31 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 11:55:31 volumio volumio[16353]: Cannot find translation for source Loopback May 26 11:55:31 volumio volumio[16353]: Cannot find translation for source TIDAL May 26 11:55:31 volumio volumio[16353]: info: Adding TIDAL REST API Endpoints May 26 11:55:31 volumio qobuz-connect[17570]: 20260526 11:55:31.138 [17570.17570] INFO SampleApp: Playback volume changed: 75 May 26 11:55:31 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:31 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:31 volumio volumiossh-tunnel[17565]: Warning: Permanently added '[us1.myvolumio.org]:2222' (RSA) to the list of known hosts. May 26 11:55:31 volumio volumio[16353]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 26 11:55:31 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 26 11:55:32 volumio volumio[16353]: info: TidalConnect service stoped! May 26 11:55:32 volumio volumio[16353]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 26 11:55:32 volumio volumio[16353]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect May 26 11:55:32 volumio sudo[17585]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 26 11:55:32 volumio sudo[17585]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:33 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. May 26 11:55:33 volumio sudo[17585]: pam_unix(sudo:session): session closed for user root May 26 11:55:33 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 11:55:33 volumio volumio[16353]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 May 26 11:55:33 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:33 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:33 volumio volumio[16353]: info: Executing endpoint tc_getconfig May 26 11:55:33 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 26 11:55:33 volumio vtcs[17588]: STARTING TidalConnect services, version: 1.6.1 May 26 11:55:33 volumio vtcs[17588]: STARTED TidalConnect services. May 26 11:55:33 volumio volumio[16353]: info: Executing endpoint tc_connect May 26 11:55:33 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 26 11:55:33 volumio volumio[16353]: info: Connecting to TidalConnect May 26 11:55:33 volumio volumio[16353]: info: CoreCommandRouter::servicePushState May 26 11:55:33 volumio volumio[16353]: info: CoreStateMachine::pushState May 26 11:55:33 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:33 volumio volumio[16353]: info: CoreCommandRouter::volumioPushState May 26 11:55:33 volumio volumio[16353]: info: MRS: Pushing multiroomSync output update for this device May 26 11:55:33 volumio volumio[16353]: info: MRS: Pushing multiroomSync output May 26 11:55:33 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:33 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:33 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:33 volumio volumio[16353]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect May 26 11:55:33 volumio volumio[16353]: info: CoreCommandRouter::servicePushState May 26 11:55:33 volumio volumio[16353]: info: CoreStateMachine::pushState May 26 11:55:33 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:33 volumio volumio[16353]: info: CoreCommandRouter::volumioPushState May 26 11:55:33 volumio volumio[16353]: info: MRS: Pushing multiroomSync output update for this device May 26 11:55:33 volumio volumio[16353]: info: MRS: Pushing multiroomSync output May 26 11:55:33 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:33 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:33 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:33 volumio volumio[16353]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect May 26 11:55:33 volumio volumio[16353]: info: PeppyMeterBasic ---peppymeterbasic status stop May 26 11:55:33 volumio sudo[17605]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 26 11:55:33 volumio sudo[17605]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:33 volumio volumio[16353]: info: PeppyMeterBasic ---peppymeterbasic status stop May 26 11:55:33 volumio volumio[16353]: SPOTIFY: RECEIVED VOLUMIO VOLUME 0 May 26 11:55:33 volumio volumio[16353]: SPOTIFY: RECEIVED VOLUMIO VOLUME 0 May 26 11:55:33 volumio sudo[17608]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 26 11:55:33 volumio sudo[17608]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:33 volumio sudo[17605]: pam_unix(sudo:session): session closed for user root May 26 11:55:33 volumio volumio[16353]: info: peppymeterbasic Daemon Stop May 26 11:55:33 volumio sudo[17608]: pam_unix(sudo:session): session closed for user root May 26 11:55:33 volumio volumio[16353]: info: peppymeterbasic Daemon Stop May 26 11:55:35 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 11:55:35 volumio volumio[16353]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 26 11:55:35 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 26 11:55:35 volumio volumio[16353]: info: Received Get System Version May 26 11:55:35 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 11:55:35 volumio volumio[16353]: info: Received Get System Info May 26 11:55:35 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 11:55:35 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 11:55:35 volumio volumio[16353]: info: Discovery: Getting this device information May 26 11:55:35 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:35 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:35 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 11:55:36 volumio volumio[16353]: info: TidalConnect service started! May 26 11:55:36 volumio volumio[16353]: [Metrics] CommandRouter: 45s 100.41ms May 26 11:55:36 volumio volumio[16353]: info: CoreCommandRouter::volumiosetStartupVolume May 26 11:55:36 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:36 volumio volumio[16353]: info: VolumeController:: Setting startup Volume 100 May 26 11:55:36 volumio volumio[16353]: info: VolumeController::SetAlsaVolume100 May 26 11:55:36 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 11:55:36 volumio volumio[16353]: info: CoreCommandRouter::Close All Modals sent May 26 11:55:36 volumio volumio[16353]: info: CoreCommandRouter::Close All Modals sent May 26 11:55:36 volumio volumio[16353]: info: CoreStateMachine::pushState May 26 11:55:36 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:36 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 11:55:36 volumio volumio[16353]: info: CoreCommandRouter::volumioPushState May 26 11:55:36 volumio volumio[16353]: info: MRS: Pushing multiroomSync output update for this device May 26 11:55:36 volumio volumio[16353]: info: MRS: Pushing multiroomSync output May 26 11:55:36 volumio volumio[16353]: info: CoreCommandRouter::volumioGetState May 26 11:55:36 volumio volumio[16353]: info: CorePlayQueue::getTrack 0 May 26 11:55:36 volumio volumio[16353]: info: PeppyMeterBasic ---peppymeterbasic status stop May 26 11:55:36 volumio volumio[16353]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 26 11:55:36 volumio volumio[16353]: SPOTIFY: SPOTIFY VOLUME 0 May 26 11:55:36 volumio volumio[16353]: SPOTIFY: VOLUMIO VOLUME 100 May 26 11:55:36 volumio volumio[16353]: SPOTIFY: DELTA VOLUME ENOUGH: true May 26 11:55:36 volumio volumio[16353]: info: Setting Spotify Volume from Volumio: 100 May 26 11:55:36 volumio sudo[17628]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service May 26 11:55:36 volumio sudo[17628]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 11:55:36 volumio sudo[17628]: pam_unix(sudo:session): session closed for user root May 26 11:55:36 volumio volumio[16353]: info: peppymeterbasic Daemon Stop May 26 11:55:37 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 26 11:55:37 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 26 11:55:37 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 26 11:55:37 volumio volumio[16353]: SPOTIFY: SETTING SPOTIFY VOLUME 100 May 26 11:55:37 volumio volumio[16353]: info: Sending Spotify command with payload to local API: /player/volume May 26 11:55:38 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:38 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 11:55:38 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 26 11:55:38 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 26 11:55:38 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 26 11:55:38 volumio volumio[16353]: info: CoreCommandRouter::volumioGetBrowseSources May 26 11:55:38 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 11:55:43 volumio volumio[16353]: info: BOOT COMPLETED May 26 11:55:43 volumio volumio[16353]: info: CALLMETHOD: user_interface peppymeterbasic updatelist May 26 11:55:43 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , updatelist May 26 11:55:43 volumio volumio[16353]: info: PeppyMeterBasic --- wget 'https://github.com/balbuze/Meter-peppymeter/raw/main/meterslist.txt' May 26 11:55:43 volumio volumio[16353]: --2026-05-26 11:55:43-- https://github.com/balbuze/Meter-peppymeter/raw/main/meterslist.txt May 26 11:55:43 volumio volumio[16353]: Resolving github.com (github.com)... 4.228.31.150 May 26 11:55:43 volumio volumio[16353]: Connecting to github.com (github.com)|4.228.31.150|:443... connected. May 26 11:55:43 volumio volumio[16353]: HTTP request sent, awaiting response... 302 Found May 26 11:55:43 volumio volumio[16353]: Location: https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/meterslist.txt [following] May 26 11:55:43 volumio volumio[16353]: --2026-05-26 11:55:43-- https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/meterslist.txt May 26 11:55:43 volumio volumio[16353]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.109.133, 185.199.110.133, 185.199.108.133, ... May 26 11:55:43 volumio volumio[16353]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.109.133|:443... connected. May 26 11:55:43 volumio volumio[16353]: HTTP request sent, awaiting response... 200 OK May 26 11:55:43 volumio volumio[16353]: Length: 362 [text/plain] May 26 11:55:43 volumio volumio[16353]: Saving to: ‘/data/plugins/user_interface/peppymeterbasic/meterslist.txt’ May 26 11:55:43 volumio volumio[16353]: 0K 100% 3.21M=0s May 26 11:55:43 volumio volumio[16353]: 2026-05-26 11:55:43 (3.21 MB/s) - ‘/data/plugins/user_interface/peppymeterbasic/meterslist.txt’ saved [362/362] May 26 11:55:44 volumio volumio[16353]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 11:55:44 volumio volumio[16353]: info: CoreCommandRouter::Close All Modals sent May 26 11:55:46 volumio volumio[16353]: info: CALLMETHOD: user_interface peppymeterbasic dlmeter [object Object] May 26 11:55:46 volumio volumio[16353]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , dlmeter May 26 11:55:48 volumio volumio[16353]: --2026-05-26 11:55:46-- https://github.com/balbuze/Meter-peppymeter/raw/main/Zipped-folders/Choose May 26 11:55:48 volumio volumio[16353]: Resolving github.com (github.com)... 4.228.31.150 May 26 11:55:48 volumio volumio[16353]: Connecting to github.com (github.com)|4.228.31.150|:443... connected. May 26 11:55:48 volumio volumio[16353]: HTTP request sent, awaiting response... 404 Not Found May 26 11:55:48 volumio volumio[16353]: 2026-05-26 11:55:47 ERROR 404: Not Found. May 26 11:55:48 volumio volumio[16353]: --2026-05-26 11:55:47-- http://a/ May 26 11:55:48 volumio volumio[16353]: Resolving a (a)... failed: Device or resource busy. May 26 11:55:48 volumio volumio[16353]: wget: unable to resolve host address ‘a’ May 26 11:55:48 volumio volumio[16353]: --2026-05-26 11:55:47-- http://packet.zip/ May 26 11:55:48 volumio volumio[16353]: Resolving packet.zip (packet.zip)... 162.255.119.167 May 26 11:55:48 volumio volumio[16353]: Connecting to packet.zip (packet.zip)|162.255.119.167|:80... connected. May 26 11:55:48 volumio volumio[16353]: HTTP request sent, awaiting response... 302 Found May 26 11:55:48 volumio volumio[16353]: Location: http://www.packet.zip/ [following] May 26 11:55:48 volumio volumio[16353]: --2026-05-26 11:55:47-- http://www.packet.zip/ May 26 11:55:48 volumio volumio[16353]: Resolving www.packet.zip (www.packet.zip)... 91.195.240.19 May 26 11:55:48 volumio volumio[16353]: Connecting to www.packet.zip (www.packet.zip)|91.195.240.19|:80... connected. May 26 11:55:48 volumio volumio[16353]: HTTP request sent, awaiting response... 403 Forbidden May 26 11:55:48 volumio volumio[16353]: 2026-05-26 11:55:48 ERROR 403: Forbidden. May 26 11:55:48 volumio volumio[16353]: error: PeppyMeterBasic --- An error occurs while downloading or installing Meters May 26 11:55:48 volumio volumio[16353]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory May 26 11:55:48 volumio volumio[16353]: /bin/rm: cannot remove 'a': No such file or directory May 26 11:55:48 volumio volumio[16353]: /bin/rm: cannot remove 'packet.zip*': No such file or directory May 26 11:55:48 volumio volumio[16353]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 11:55:48 volumio volumio[16353]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* May 26 11:55:48 volumio volumio[16353]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory May 26 11:55:48 volumio volumio[16353]: /bin/rm: cannot remove 'a': No such file or directory May 26 11:55:48 volumio volumio[16353]: /bin/rm: cannot remove 'packet.zip*': No such file or directory May 26 11:55:48 volumio volumio[16353]: at checkExecSyncError (node:child_process:887:11) May 26 11:55:48 volumio volumio[16353]: at execSync (node:child_process:959:15) May 26 11:55:48 volumio volumio[16353]: at /data/plugins/user_interface/peppymeterbasic/index.js:710:19 May 26 11:55:48 volumio volumio[16353]: at new Promise () May 26 11:55:48 volumio volumio[16353]: at peppymeterbasic.dlmeter (/data/plugins/user_interface/peppymeterbasic/index.js:685:12) May 26 11:55:48 volumio volumio[16353]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) May 26 11:55:48 volumio volumio[16353]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) May 26 11:55:48 volumio volumio[16353]: at Socket.emit (node:events:514:28) May 26 11:55:48 volumio volumio[16353]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 26 11:55:48 volumio volumio[16353]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { May 26 11:55:48 volumio volumio[16353]: status: 1, May 26 11:55:48 volumio volumio[16353]: signal: null, May 26 11:55:48 volumio volumio[16353]: output: [ May 26 11:55:48 volumio volumio[16353]: null, May 26 11:55:48 volumio volumio[16353]: , May 26 11:55:48 volumio volumio[16353]: May 26 11:55:48 volumio volumio[16353]: ], May 26 11:55:48 volumio volumio[16353]: pid: 17657, May 26 11:55:48 volumio volumio[16353]: stdout: , May 26 11:55:48 volumio volumio[16353]: stderr: May 26 11:55:48 volumio volumio[16353]: } May 26 11:55:48 volumio volumio[16353]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 11:55:49 volumio sudo[17673]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-26 11:54' May 26 11:55:49 volumio sudo[17673]: 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"