Jan 09 20:02:06 volumio-4-home wireless.js[686]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow Jan 09 20:02:06 volumio-4-home systemd[1]: setdatetime-helper.service: Deactivated successfully. Jan 09 20:02:06 volumio-4-home systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Jan 09 20:02:06 volumio-4-home systemd[1]: setdatetime-helper.service: Consumed 1.640s CPU time. Jan 09 20:02:06 volumio-4-home systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Jan 09 20:02:06 volumio-4-home systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Jan 09 20:02:06 volumio-4-home systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Jan 09 20:02:06 volumio-4-home smbd[1179]: [2026/01/09 20:02:06.269923, 0] ../../source3/smbd/server.c:1741(main) Jan 09 20:02:06 volumio-4-home smbd[1179]: smbd version 4.17.8-Raspbian started. Jan 09 20:02:06 volumio-4-home smbd[1179]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Jan 09 20:02:06 volumio-4-home systemd[1]: dpkg-db-backup.service: Deactivated successfully. Jan 09 20:02:06 volumio-4-home systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Jan 09 20:02:06 volumio-4-home systemd[1]: Started wireless.service - Wireless Services. Jan 09 20:02:06 volumio-4-home kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 09 20:02:06 volumio-4-home winbindd[1149]: [2026/01/09 20:02:06.396207, 0] ../../source3/winbindd/winbindd_idmap.c:372(wb_parent_idmap_setup_lookupname_done) Jan 09 20:02:06 volumio-4-home wireless.js[686]: WIRELESS.JS: Notified systemd about wireless ready Jan 09 20:02:06 volumio-4-home winbindd[1149]: wb_parent_idmap_setup_lookupname_done: Lookup domain name 'VOLUMIO 4 HOME' failed 'NT_STATUS_IO_TIMEOUT' Jan 09 20:02:06 volumio-4-home systemd[1]: Started volumio.service - Volumio Backend Module. Jan 09 20:02:06 volumio-4-home systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... Jan 09 20:02:06 volumio-4-home systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. Jan 09 20:02:06 volumio-4-home systemd[1]: Received SIGRTMIN+21 from PID 287 (plymouthd). Jan 09 20:02:06 volumio-4-home systemd[1]: Started smbd.service - Samba SMB Daemon. Jan 09 20:02:06 volumio-4-home systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. Jan 09 20:02:06 volumio-4-home systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. Jan 09 20:02:06 volumio-4-home systemd[1]: Received SIGRTMIN+21 from PID 287 (n/a). Jan 09 20:02:06 volumio-4-home systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 09 20:02:06 volumio-4-home systemd[1]: Reached target getty.target - Login Prompts. Jan 09 20:02:06 volumio-4-home systemd[1]: Reached target multi-user.target - Multi-User System. Jan 09 20:02:06 volumio-4-home systemd[1]: Reached target graphical.target - Graphical Interface. Jan 09 20:02:06 volumio-4-home systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Jan 09 20:02:06 volumio-4-home volumio-cpu-tweak[1209]: Setting RT Priority for mpd Jan 09 20:02:06 volumio-4-home volumio-cpu-tweak[1225]: pid 35's current scheduling policy: SCHED_OTHER Jan 09 20:02:06 volumio-4-home volumio-cpu-tweak[1225]: pid 35's current scheduling priority: 0 Jan 09 20:02:06 volumio-4-home volumio-cpu-tweak[1209]: Setting MPD Affinity Jan 09 20:02:06 volumio-4-home volumio-cpu-tweak[1226]: pid 3's current affinity mask: f Jan 09 20:02:06 volumio-4-home volumio-cpu-tweak[1209]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jan 09 20:02:06 volumio-4-home volumio-cpu-tweak[1209]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jan 09 20:02:06 volumio-4-home systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Jan 09 20:02:06 volumio-4-home systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Jan 09 20:02:06 volumio-4-home systemd[1]: Startup finished in 15.300s (kernel) + 15.500s (userspace) = 30.801s. Jan 09 20:02:06 volumio-4-home systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. Jan 09 20:02:06 volumio-4-home ntpd[861]: IO: Listen normally on 3 eth0 192.168.1.15:123 Jan 09 20:02:06 volumio-4-home ntpd[861]: IO: new interface(s) found: waking up resolver Jan 09 20:02:06 volumio-4-home ntpd[861]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Jan 09 20:02:06 volumio-4-home ntpd[861]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Jan 09 20:02:06 volumio-4-home ntpd[861]: DNS: Pool taking: 172.232.63.219 Jan 09 20:02:06 volumio-4-home ntpd[861]: DNS: Pool taking: 5.42.158.119 Jan 09 20:02:06 volumio-4-home ntpd[861]: DNS: Pool taking: 37.59.63.125 Jan 09 20:02:06 volumio-4-home ntpd[861]: DNS: Pool taking: 51.210.178.126 Jan 09 20:02:06 volumio-4-home ntpd[861]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Jan 09 20:02:07 volumio-4-home winbindd[1160]: [2026/01/09 20:02:07.759145, 0] ../../source3/winbindd/winbindd_dual.c:162(child_write_response) Jan 09 20:02:07 volumio-4-home winbindd[1160]: Could not write result Jan 09 20:02:07 volumio-4-home ntpd[861]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Jan 09 20:02:07 volumio-4-home ntpd[861]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Jan 09 20:02:07 volumio-4-home ntpd[861]: DNS: Pool taking: 38.143.19.16 Jan 09 20:02:07 volumio-4-home ntpd[861]: DNS: Pool taking: 82.67.41.119 Jan 09 20:02:07 volumio-4-home ntpd[861]: DNS: Pool taking: 82.165.165.250 Jan 09 20:02:07 volumio-4-home ntpd[861]: DNS: Pool taking: 109.190.177.203 Jan 09 20:02:07 volumio-4-home ntpd[861]: DNS: Pool taking: 2001:41d0:8:7a7d::1 Jan 09 20:02:07 volumio-4-home ntpd[861]: DNS: Pool taking: 2606:4700:f1::1 Jan 09 20:02:07 volumio-4-home ntpd[861]: DNS: Pool taking: 2a01:cb00:129e:a803::203 Jan 09 20:02:07 volumio-4-home ntpd[861]: DNS: Pool taking: 2a12:8ac1:a0::123:2 Jan 09 20:02:07 volumio-4-home ntpd[861]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Jan 09 20:02:08 volumio-4-home ntpd[861]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Jan 09 20:02:08 volumio-4-home ntpd[861]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Jan 09 20:02:08 volumio-4-home ntpd[861]: DNS: Pool taking: 162.159.200.123 Jan 09 20:02:08 volumio-4-home ntpd[861]: DNS: Pool taking: 109.190.177.200 Jan 09 20:02:08 volumio-4-home ntpd[861]: DNS: Pool taking: 45.90.162.253 Jan 09 20:02:08 volumio-4-home ntpd[861]: DNS: Pool taking: 172.232.44.156 Jan 09 20:02:08 volumio-4-home ntpd[861]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Jan 09 20:02:09 volumio-4-home ntpd[861]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Jan 09 20:02:09 volumio-4-home ntpd[861]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Jan 09 20:02:09 volumio-4-home ntpd[861]: DNS: Pool taking: 54.37.253.59 Jan 09 20:02:09 volumio-4-home ntpd[861]: DNS: Pool taking: 92.222.117.115 Jan 09 20:02:09 volumio-4-home ntpd[861]: DNS: Pool taking: 82.64.81.218 Jan 09 20:02:09 volumio-4-home ntpd[861]: DNS: Pool taking: 82.64.131.93 Jan 09 20:02:09 volumio-4-home ntpd[861]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Jan 09 20:02:09 volumio-4-home volumio-remote-updater[680]: [2026-01-09 20:02:09] [info] asio async_connect error: asio.system:111 (Connection refused) Jan 09 20:02:09 volumio-4-home volumio-remote-updater[680]: [2026-01-09 20:02:09] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Jan 09 20:02:09 volumio-4-home volumio-remote-updater[680]: [2026-01-09 20:02:09] [error] handle_connect error: Connection refused Jan 09 20:02:11 volumio-4-home volumio[1206]: info: ------------------------------------------- Jan 09 20:02:11 volumio-4-home volumio[1206]: info: ----- Volumio3 ---- Jan 09 20:02:11 volumio-4-home volumio[1206]: info: ------------------------------------------- Jan 09 20:02:11 volumio-4-home volumio[1206]: info: ----- System startup ---- Jan 09 20:02:11 volumio-4-home volumio[1206]: info: ------------------------------------------- Jan 09 20:02:12 volumio-4-home systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1. Jan 09 20:02:12 volumio-4-home systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 09 20:02:12 volumio-4-home systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 09 20:02:12 volumio-4-home upmpdcli[1242]: Could not open config: /tmp/upmpdcli.conf Jan 09 20:02:12 volumio-4-home systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 09 20:02:12 volumio-4-home systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 09 20:02:12 volumio-4-home volumio[1206]: info: MYVOLUMIO Environment detected Jan 09 20:02:13 volumio-4-home ntpd[861]: CLOCK: time stepped by 0.349628 Jan 09 20:02:13 volumio-4-home ntpd[861]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Plugin folders cleanup Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Scanning into folder /volumio/app/plugins/ Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Scanning category audio_interface Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Scanning category miscellanea Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Scanning category music_service Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Scanning category plugins.json Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Scanning category system_controller Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Scanning category user_interface Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Scanning into folder /data/plugins/ Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Scanning category music_service Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Scanning category system_hardware Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Plugin folders cleanup completed Jan 09 20:02:13 volumio-4-home volumio[1206]: info: ------------------------------------------- Jan 09 20:02:13 volumio-4-home volumio[1206]: info: ----- Core plugins startup ---- Jan 09 20:02:13 volumio-4-home volumio[1206]: info: ------------------------------------------- Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Loading plugins from folder /volumio/app/plugins/ Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Adding plugin upnp to MyMusic Plugins Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Loading plugins from folder /data/plugins/ Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Loading plugin "system"... Jan 09 20:02:13 volumio-4-home volumio[1206]: info: Loading plugin "appearance"... Jan 09 20:02:15 volumio-4-home volumio[1206]: info: Loading plugin "network"... Jan 09 20:02:15 volumio-4-home volumio[1206]: info: Refreshing Cached IP Addresses Jan 09 20:02:15 volumio-4-home sudo[1251]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 09 20:02:15 volumio-4-home sudo[1251]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:15 volumio-4-home sudo[1252]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 09 20:02:15 volumio-4-home sudo[1252]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:15 volumio-4-home volumio[1206]: info: Loading plugin "services"... Jan 09 20:02:15 volumio-4-home volumio[1206]: info: Loading plugin "alsa_controller"... Jan 09 20:02:15 volumio-4-home sudo[1251]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:15 volumio-4-home sudo[1252]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:15 volumio-4-home sudo[1259]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 09 20:02:15 volumio-4-home sudo[1259]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:16 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 20:02:16 volumio-4-home volumio[1206]: info: Loading plugin "wizard"... Jan 09 20:02:16 volumio-4-home volumio[1206]: info: Loading plugin "networkfs"... Jan 09 20:02:16 volumio-4-home volumio[1206]: info: Starting Udev Watcher for removable devices Jan 09 20:02:16 volumio-4-home volumio[1206]: info: Ignoring mount for partition: boot Jan 09 20:02:16 volumio-4-home volumio[1206]: info: Ignoring mount for partition: volumio Jan 09 20:02:16 volumio-4-home volumio[1206]: info: Ignoring mount for partition: volumio_data Jan 09 20:02:16 volumio-4-home volumio[1206]: info: Mounting Device TOSHIBA_EXT Jan 09 20:02:16 volumio-4-home sudo[1290]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/TOSHIBA_EXT -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jan 09 20:02:16 volumio-4-home sudo[1290]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:18 volumio-4-home sudo[1259]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:19 volumio-4-home sudo[1290]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:19 volumio-4-home ntfs-3g[1295]: Version 2022.10.3 integrated FUSE 28 Jan 09 20:02:19 volumio-4-home ntfs-3g[1295]: Mounted /dev/sda1 (Read-Write, label "TOSHIBA EXT", NTFS 3.1) Jan 09 20:02:19 volumio-4-home ntfs-3g[1295]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Jan 09 20:02:19 volumio-4-home ntfs-3g[1295]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Jan 09 20:02:19 volumio-4-home ntfs-3g[1295]: Global ownership and permissions enforced, configuration type 7 Jan 09 20:02:19 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 09 20:02:19 volumio-4-home volumio[1206]: info: Loading plugin "volumio_command_line_client"... Jan 09 20:02:19 volumio-4-home volumio[1206]: info: Loading plugin "upnp"... Jan 09 20:02:19 volumio-4-home volumio[1206]: info: [1767985339619] Starting Upmpd Daemon Jan 09 20:02:19 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 09 20:02:19 volumio-4-home volumio[1206]: info: Loading plugin "my_music"... Jan 09 20:02:19 volumio-4-home volumio[1206]: info: Loading plugin "mpd"... Jan 09 20:02:20 volumio-4-home volumio-remote-updater[680]: [2026-01-09 20:02:20] [connect] Successful connection Jan 09 20:02:20 volumio-4-home volumio[1206]: info: Loading plugin "upnp_browser"... Jan 09 20:02:23 volumio-4-home volumio[1206]: info: Starting UPNP Browser Jan 09 20:02:23 volumio-4-home volumio[1206]: info: Loading plugin "alarm-clock"... Jan 09 20:02:23 volumio-4-home volumio[1206]: info: Loading plugin "airplay_emulation"... Jan 09 20:02:23 volumio-4-home volumio[1206]: info: Starting Shairport Sync Jan 09 20:02:23 volumio-4-home volumio[1206]: info: Loading plugin "last_100"... Jan 09 20:02:23 volumio-4-home volumio[1206]: info: Loading plugin "webradio"... Jan 09 20:02:23 volumio-4-home volumio[1206]: info: Loading plugin "i2s_dacs"... Jan 09 20:02:23 volumio-4-home volumio[1206]: info: Loading plugin "volumiodiscovery"... Jan 09 20:02:24 volumio-4-home volumio[1206]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 09 20:02:24 volumio-4-home node[1206]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 09 20:02:24 volumio-4-home volumio[1206]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 09 20:02:24 volumio-4-home volumio[1206]: *** WARNING *** For more information see Jan 09 20:02:24 volumio-4-home volumio[1206]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 09 20:02:24 volumio-4-home volumio[1206]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 09 20:02:24 volumio-4-home volumio[1206]: *** WARNING *** For more information see Jan 09 20:02:24 volumio-4-home node[1206]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 09 20:02:24 volumio-4-home node[1206]: *** WARNING *** For more information see Jan 09 20:02:24 volumio-4-home node[1206]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 09 20:02:24 volumio-4-home node[1206]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 09 20:02:24 volumio-4-home node[1206]: *** WARNING *** For more information see Jan 09 20:02:24 volumio-4-home volumio[1206]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 09 20:02:24 volumio-4-home volumio[1206]: info: Discovery: Started advertising with name: Volumio 4 home Jan 09 20:02:24 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 09 20:02:24 volumio-4-home volumio[1206]: info: Loading plugin "outputs"... Jan 09 20:02:24 volumio-4-home volumio[1206]: info: Loading plugin "albumart"... Jan 09 20:02:24 volumio-4-home volumio[1206]: info: Plugin example_plugin is not enabled Jan 09 20:02:24 volumio-4-home volumio[1206]: info: Loading plugin "inputs"... Jan 09 20:02:24 volumio-4-home volumio[1206]: info: Loading plugin "updater_comm"... Jan 09 20:02:24 volumio-4-home systemd[1]: systemd-fsckd.service: Deactivated successfully. Jan 09 20:02:24 volumio-4-home volumio[1206]: info: Plugin mpdemulation is not enabled Jan 09 20:02:24 volumio-4-home volumio[1206]: info: Loading plugin "rest_api"... Jan 09 20:02:24 volumio-4-home volumio[1206]: info: Loading plugin "websocket"... Jan 09 20:02:24 volumio-4-home volumio[1206]: info: Starting Socket.io Server version 1.7.4 Jan 09 20:02:24 volumio-4-home volumio[1206]: info: Loading plugin "radio_paradise"... Jan 09 20:02:25 volumio-4-home volumio[1298]: Forking 3 albumart workers Jan 09 20:02:26 volumio-4-home volumio[1206]: info: Applying required configuration parameters for plugin radio_paradise Jan 09 20:02:26 volumio-4-home volumio[1206]: info: [1767985346180] [RadioParadise] API delay: 5 Jan 09 20:02:26 volumio-4-home volumio[1206]: info: Loading plugin "audiophonicsonoff"... Jan 09 20:02:28 volumio-4-home systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Jan 09 20:02:28 volumio-4-home systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 09 20:02:28 volumio-4-home systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 09 20:02:28 volumio-4-home upmpdcli[1352]: Could not open config: /tmp/upmpdcli.conf Jan 09 20:02:28 volumio-4-home systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 09 20:02:28 volumio-4-home systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 09 20:02:28 volumio-4-home volumio[1206]: info: Applying required configuration parameters for plugin audiophonicsonoff Jan 09 20:02:28 volumio-4-home volumio[1206]: info: Audiophonics on/off initiated Jan 09 20:02:29 volumio-4-home volumio[1206]: info: Loading i18n strings for locale fr Jan 09 20:02:29 volumio-4-home volumio[1206]: Updating browse sources language Jan 09 20:02:29 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 20:02:29 volumio-4-home systemd[1]: systemd-hostnamed.service: Deactivated successfully. Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreCommandRouter::initPlayerControls Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 20:02:31 volumio-4-home volumio[1206]: Express server listening on port 3000 Jan 09 20:02:31 volumio-4-home volumio[1206]: [Metrics] WebUI: 20s 458.38ms Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreStateMachine::resetVolumioState Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreStateMachine::getcurrentVolume Jan 09 20:02:31 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioRetrievevolume Jan 09 20:02:31 volumio-4-home sudo[1363]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 09 20:02:31 volumio-4-home sudo[1364]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 09 20:02:31 volumio-4-home sudo[1364]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:31 volumio-4-home sudo[1363]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:31 volumio-4-home sudo[1364]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:31 volumio-4-home sudo[1363]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:32 volumio-4-home volumio[1206]: info: Volumio Network Manager: Network status updated: 1 Jan 09 20:02:32 volumio-4-home volumio[1206]: Unable to parse: Jan 09 20:02:32 volumio-4-home volumio[1206]: Simple mixer control 'Analogue Playback Boost',0 Jan 09 20:02:32 volumio-4-home volumio[1206]: Capabilities: volume Jan 09 20:02:32 volumio-4-home volumio[1206]: Playback channels: Front Left - Front Right Jan 09 20:02:32 volumio-4-home volumio[1206]: Capture channels: Front Left - Front Right Jan 09 20:02:32 volumio-4-home volumio[1206]: Limits: 0 - 1 Jan 09 20:02:32 volumio-4-home volumio[1206]: Front Left: 1 [100%] [0.80dB] Jan 09 20:02:32 volumio-4-home volumio[1206]: Front Right: 1 [100%] [0.80dB] Jan 09 20:02:32 volumio-4-home volumio[1206]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Jan 09 20:02:33 volumio-4-home volumio[1206]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.93 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 1 Jan 09 20:02:33 volumio-4-home volumio[1206]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.93 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 2 Jan 09 20:02:33 volumio-4-home volumio[1206]: Unable to parse: Jan 09 20:02:33 volumio-4-home volumio[1206]: Simple mixer control 'Analogue Playback Boost',0 Jan 09 20:02:33 volumio-4-home volumio[1206]: Capabilities: volume Jan 09 20:02:33 volumio-4-home volumio[1206]: Playback channels: Front Left - Front Right Jan 09 20:02:33 volumio-4-home volumio[1206]: Capture channels: Front Left - Front Right Jan 09 20:02:33 volumio-4-home volumio[1206]: Limits: 0 - 1 Jan 09 20:02:33 volumio-4-home volumio[1206]: Front Left: 1 [100%] [0.80dB] Jan 09 20:02:33 volumio-4-home volumio[1206]: Front Right: 1 [100%] [0.80dB] Jan 09 20:02:33 volumio-4-home volumio[1206]: info: VolumeController:: Volume=undefined Mute =false Jan 09 20:02:33 volumio-4-home volumio[1206]: info: CoreStateMachine::pushState Jan 09 20:02:33 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:33 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 20:02:33 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioPushState Jan 09 20:02:33 volumio-4-home volumio[1206]: info: CoreStateMachine::updateTrackBlock Jan 09 20:02:33 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrackBlock Jan 09 20:02:33 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioRetrievevolume Jan 09 20:02:33 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 20:02:33 volumio-4-home volumio[1206]: info: Reloading queue from file Jan 09 20:02:33 volumio-4-home volumio[1206]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.93 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 3 Jan 09 20:02:34 volumio-4-home volumio[1206]: info: CoreStateMachine::setRepeat true single undefined Jan 09 20:02:34 volumio-4-home volumio[1206]: info: CoreStateMachine::pushState Jan 09 20:02:34 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:34 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 20:02:34 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioPushState Jan 09 20:02:34 volumio-4-home volumio[1206]: info: CoreStateMachine::setRandom null Jan 09 20:02:34 volumio-4-home volumio[1206]: info: CoreStateMachine::pushState Jan 09 20:02:34 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:34 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioPushState Jan 09 20:02:34 volumio-4-home volumio[1206]: info: Setting Device type: Raspberry PI Jan 09 20:02:34 volumio-4-home volumio[1206]: info: Completed loading Core Plugins Jan 09 20:02:34 volumio-4-home volumio[1206]: info: Preparing to generate the ALSA configuration file Jan 09 20:02:34 volumio-4-home volumio[1206]: Unable to parse: Jan 09 20:02:34 volumio-4-home volumio[1206]: Simple mixer control 'Analogue Playback Boost',0 Jan 09 20:02:34 volumio-4-home volumio[1206]: Capabilities: volume Jan 09 20:02:34 volumio-4-home volumio[1206]: Playback channels: Front Left - Front Right Jan 09 20:02:34 volumio-4-home volumio[1206]: Capture channels: Front Left - Front Right Jan 09 20:02:34 volumio-4-home volumio[1206]: Limits: 0 - 1 Jan 09 20:02:34 volumio-4-home volumio[1206]: Front Left: 1 [100%] [0.80dB] Jan 09 20:02:34 volumio-4-home volumio[1206]: Front Right: 1 [100%] [0.80dB] Jan 09 20:02:34 volumio-4-home volumio[1206]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Jan 09 20:02:34 volumio-4-home volumio[1206]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.93 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 4 Jan 09 20:02:34 volumio-4-home volumio[1308]: Starting albumart workers Jan 09 20:02:35 volumio-4-home volumio[1206]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.93 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 5 Jan 09 20:02:35 volumio-4-home sudo[1380]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 09 20:02:35 volumio-4-home volumio[1206]: Unable to parse: Jan 09 20:02:35 volumio-4-home volumio[1206]: Simple mixer control 'Analogue Playback Boost',0 Jan 09 20:02:35 volumio-4-home volumio[1206]: Capabilities: volume Jan 09 20:02:35 volumio-4-home volumio[1206]: Playback channels: Front Left - Front Right Jan 09 20:02:35 volumio-4-home volumio[1206]: Capture channels: Front Left - Front Right Jan 09 20:02:35 volumio-4-home volumio[1206]: Limits: 0 - 1 Jan 09 20:02:35 volumio-4-home volumio[1206]: Front Left: 1 [100%] [0.80dB] Jan 09 20:02:35 volumio-4-home volumio[1206]: Front Right: 1 [100%] [0.80dB] Jan 09 20:02:35 volumio-4-home volumio[1206]: info: VolumeController:: Volume=undefined Mute =false Jan 09 20:02:35 volumio-4-home volumio[1206]: info: CoreStateMachine::pushState Jan 09 20:02:35 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:35 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioPushState Jan 09 20:02:35 volumio-4-home sudo[1380]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:35 volumio-4-home volumio[1206]: info: Discovery: adding 0ba31fa3-76ab-4849-b687-8cf6e8c67e03 Jan 09 20:02:35 volumio-4-home volumio[1206]: info: Discovery: Found device Volumio 4 home Jan 09 20:02:35 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetState Jan 09 20:02:35 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:35 volumio-4-home volumio[1206]: info: Discovery: this is already registered, 0ba31fa3-76ab-4849-b687-8cf6e8c67e03 Jan 09 20:02:35 volumio-4-home volumio[1206]: info: Discovery: Found device Volumio 4 home Jan 09 20:02:35 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetState Jan 09 20:02:35 volumio-4-home volumio-remote-updater[680]: [2026-01-09 20:02:35] [connect] Successful connection Jan 09 20:02:35 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:35 volumio-4-home volumio-remote-updater[680]: [2026-01-09 20:02:35] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1767985355 101 Jan 09 20:02:35 volumio-4-home volumio[1309]: Starting albumart workers Jan 09 20:02:35 volumio-4-home volumio[1206]: 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: 6 Jan 09 20:02:35 volumio-4-home volumio[1206]: info: Asound.conf file written Jan 09 20:02:35 volumio-4-home volumio[1310]: Starting albumart workers Jan 09 20:02:35 volumio-4-home sudo[1385]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 09 20:02:35 volumio-4-home sudo[1385]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:35 volumio-4-home sudo[1385]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:36 volumio-4-home volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 09 20:02:36 volumio-4-home volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 09 20:02:36 volumio-4-home volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Jan 09 20:02:36 volumio-4-home volumio[1206]: info: Output device has changed, restarting MPD Jan 09 20:02:36 volumio-4-home volumio[1206]: info: Output device has changed, restarting Shairport Sync Jan 09 20:02:36 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:36 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 20:02:36 volumio-4-home sudo[1393]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 20:02:36 volumio-4-home sudo[1393]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:36 volumio-4-home sudo[1392]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 20:02:36 volumio-4-home sudo[1392]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:36 volumio-4-home sudo[1393]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:36 volumio-4-home volumio[1206]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 20:02:36 volumio-4-home volumio[1206]: info: ___________ START PLUGINS ___________ Jan 09 20:02:36 volumio-4-home volumio[1206]: info: ControllerMpd::onStart: Initializing MPD Jan 09 20:02:36 volumio-4-home volumio[1206]: info: Creating MPD Configuration file Jan 09 20:02:36 volumio-4-home systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Jan 09 20:02:36 volumio-4-home systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 20:02:36 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 20:02:36 volumio-4-home systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 20:02:36 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 20:02:36 volumio-4-home volumio[1206]: info: [1767985356611] CoreMusicLibrary::Adding element Serveurs Média Jan 09 20:02:36 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 20:02:36 volumio-4-home sudo[1411]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 20:02:36 volumio-4-home sudo[1411]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:36 volumio-4-home sudo[1411]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:36 volumio-4-home sudo[1422]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 09 20:02:36 volumio-4-home sudo[1422]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 09 20:02:36 volumio-4-home volumio[1206]: info: UPNP Browser: Client initialized successfully Jan 09 20:02:36 volumio-4-home sudo[1441]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jan 09 20:02:36 volumio-4-home sudo[1422]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:36 volumio-4-home sudo[1425]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 20:02:36 volumio-4-home sudo[1425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:37 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:37 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 20:02:37 volumio-4-home systemd[1]: mpd.service: Deactivated successfully. Jan 09 20:02:37 volumio-4-home systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 09 20:02:37 volumio-4-home systemd[1]: mpd.socket: Deactivated successfully. Jan 09 20:02:37 volumio-4-home systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 09 20:02:37 volumio-4-home systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 09 20:02:37 volumio-4-home volumio[1206]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 20:02:37 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:37 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 20:02:37 volumio-4-home systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 09 20:02:37 volumio-4-home systemd[1]: Starting mpd.service - Music Player Daemon... Jan 09 20:02:37 volumio-4-home sudo[1451]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 09 20:02:37 volumio-4-home sudo[1451]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 09 20:02:37 volumio-4-home sudo[1460]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jan 09 20:02:37 volumio-4-home sudo[1451]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:37 volumio-4-home volumio[1206]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 20:02:37 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 20:02:37 volumio-4-home volumio[1206]: info: [1767985357599] CoreMusicLibrary::Adding element Last_100 Jan 09 20:02:37 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 20:02:37 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 20:02:37 volumio-4-home volumio[1206]: info: [1767985357649] CoreMusicLibrary::Adding element Webradio Jan 09 20:02:37 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 20:02:37 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 20:02:37 volumio-4-home volumio[1206]: info: Initializing BBC Radios Jan 09 20:02:38 volumio-4-home systemd[1]: setdatetime-helper.service: Deactivated successfully. Jan 09 20:02:38 volumio-4-home systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Jan 09 20:02:38 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 20:02:38 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 20:02:38 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 20:02:38 volumio-4-home volumio[1206]: info: [1767985358436] CoreMusicLibrary::Adding element Radio Paradise Jan 09 20:02:38 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 20:02:38 volumio-4-home volumio[1206]: Cannot find translation for source Radio Paradise Jan 09 20:02:38 volumio-4-home volumio[1206]: info: Configuring GPIO pins Jan 09 20:02:38 volumio-4-home volumio[1206]: info: Soft shutdown GPIO 516 binding... OK Jan 09 20:02:38 volumio-4-home volumio[1206]: info: Hardware button GPIO 529 binding... OK Jan 09 20:02:38 volumio-4-home volumio[1206]: info: Boot OK GPIO 534 binding... OK Jan 09 20:02:38 volumio-4-home volumio[1206]: info: Volumio Calling Home Jan 09 20:02:43 volumio-4-home volumio[1206]: info: MPD Permissions set Jan 09 20:02:43 volumio-4-home volumio[1206]: info: MPD Permissions set Jan 09 20:02:43 volumio-4-home volumio[1206]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.93 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 7 Jan 09 20:02:43 volumio-4-home volumio[1206]: info: Volumio called home Jan 09 20:02:43 volumio-4-home systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Jan 09 20:02:43 volumio-4-home systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 09 20:02:43 volumio-4-home systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 09 20:02:43 volumio-4-home sudo[1380]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:43 volumio-4-home volumio[1206]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.93 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 8 Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:02:44 volumio-4-home mpd[1461]: 2026-01-09T20:02:44 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 09 20:02:44 volumio-4-home systemd[1]: Started mpd.service - Music Player Daemon. Jan 09 20:02:44 volumio-4-home volumio[1206]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jan 09 20:02:44 volumio-4-home sudo[1425]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:44 volumio-4-home sudo[1392]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:44 volumio-4-home volumio[1206]: info: Upmpdcli Daemon Started Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetVisibleSources Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetState Jan 09 20:02:44 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetQueue Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreStateMachine::getQueue Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CorePlayQueue::getQueue Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Received Get System Info Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Discovery: Getting this device information Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetState Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetState Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Listing playlists Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Received Get System Info Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Discovery: Getting this device information Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetState Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Received Get System Info Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Discovery: Getting this device information Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetState Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Received Get System Version Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Received Get System Info Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Discovery: Getting this device information Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetState Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetVisibleSources Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetState Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetQueue Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreStateMachine::getQueue Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CorePlayQueue::getQueue Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Received Get System Info Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Discovery: Getting this device information Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetState Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetState Jan 09 20:02:45 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Listing playlists Jan 09 20:02:45 volumio-4-home volumio[1206]: info: Completed starting Core Plugins Jan 09 20:02:45 volumio-4-home volumio[1206]: info: ------------------------------------------- Jan 09 20:02:45 volumio-4-home volumio[1206]: info: ----- MyVolumio plugins startup ---- Jan 09 20:02:45 volumio-4-home volumio[1206]: info: ------------------------------------------- Jan 09 20:02:45 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 09 20:02:47 volumio-4-home volumio[1206]: info: Starting Shairport Sync Jan 09 20:02:47 volumio-4-home volumio[1206]: info: Starting Shairport Sync Jan 09 20:02:47 volumio-4-home volumio[1206]: info: Starting Shairport Sync Jan 09 20:02:47 volumio-4-home sudo[1564]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 20:02:47 volumio-4-home sudo[1564]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:47 volumio-4-home sudo[1566]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 20:02:47 volumio-4-home systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 09 20:02:47 volumio-4-home systemd[1]: shairport-sync.service: Deactivated successfully. Jan 09 20:02:47 volumio-4-home systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 20:02:47 volumio-4-home systemd[1]: shairport-sync.service: Consumed 1.917s CPU time. Jan 09 20:02:47 volumio-4-home sudo[1566]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:47 volumio-4-home sudo[1569]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 20:02:47 volumio-4-home sudo[1569]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:47 volumio-4-home systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 20:02:47 volumio-4-home sudo[1564]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:47 volumio-4-home systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 09 20:02:47 volumio-4-home systemd[1]: shairport-sync.service: Deactivated successfully. Jan 09 20:02:47 volumio-4-home systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 20:02:47 volumio-4-home systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 09 20:02:47 volumio-4-home sudo[1566]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:47 volumio-4-home sudo[1569]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:47 volumio-4-home volumio[1206]: error: MPD error: The expression evaluated to a falsy value: Jan 09 20:02:47 volumio-4-home volumio[1206]: assert.ok(self.idling) Jan 09 20:02:47 volumio-4-home volumio[1206]: error: The expression evaluated to a falsy value: Jan 09 20:02:47 volumio-4-home volumio[1206]: assert.ok(self.idling) Jan 09 20:02:47 volumio-4-home volumio[1206]: info: MPD running with PID1461 Jan 09 20:02:47 volumio-4-home volumio[1206]: ,establishing connection Jan 09 20:02:48 volumio-4-home volumio[1206]: error: updateQueue error: null Jan 09 20:02:48 volumio-4-home volumio[1206]: info: Shairport-Sync Started Jan 09 20:02:48 volumio-4-home volumio[1206]: Error adding Membership: Error: addMembership EINVAL Jan 09 20:02:48 volumio-4-home volumio[1206]: info: Shairport-Sync Started Jan 09 20:02:48 volumio-4-home volumio[1206]: info: Shairport-Sync Started Jan 09 20:02:48 volumio-4-home volumio[1206]: error: updateQueue error: null Jan 09 20:02:48 volumio-4-home sudo[1603]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 09 20:02:48 volumio-4-home sudo[1603]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:49 volumio-4-home systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Jan 09 20:02:49 volumio-4-home sudo[1603]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:49 volumio-4-home mpd_monitor.sh[1605]: MPD Monitor Service: Starting MPD Monitor Service Jan 09 20:02:49 volumio-4-home volumio[1206]: info: Successfully started MPD Monitor Jan 09 20:02:49 volumio-4-home sudo[1610]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 09 20:02:49 volumio-4-home sudo[1610]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:02:49 volumio-4-home systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Jan 09 20:02:49 volumio-4-home systemd[1]: mpd_monitor.service: Deactivated successfully. Jan 09 20:02:49 volumio-4-home systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Jan 09 20:02:49 volumio-4-home systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Jan 09 20:02:49 volumio-4-home mpd_monitor.sh[1616]: MPD Monitor Service: Starting MPD Monitor Service Jan 09 20:02:49 volumio-4-home sudo[1610]: pam_unix(sudo:session): session closed for user root Jan 09 20:02:49 volumio-4-home volumio[1206]: info: Successfully started MPD Monitor Jan 09 20:02:50 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jan 09 20:02:50 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetState Jan 09 20:02:50 volumio-4-home volumio[1206]: info: CorePlayQueue::getTrack 0 Jan 09 20:02:51 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jan 09 20:02:51 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 09 20:02:59 volumio-4-home upmpdcli[1636]: writing RSA key Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 09 20:03:05 volumio-4-home volumio[1206]: info: Adding plugin bluetooth to MyMusic Plugins Jan 09 20:03:05 volumio-4-home volumio[1206]: info: Adding plugin multiroom to MyMusic Plugins Jan 09 20:03:05 volumio-4-home volumio[1206]: info: Adding plugin metavolumio to MyMusic Plugins Jan 09 20:03:05 volumio-4-home volumio[1206]: info: Adding plugin cd_controller to MyMusic Plugins Jan 09 20:03:05 volumio-4-home volumio[1206]: info: Adding plugin qobuzconnect to MyMusic Plugins Jan 09 20:03:05 volumio-4-home volumio[1206]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 09 20:03:05 volumio-4-home volumio[1206]: info: Adding plugin tidalconnect to MyMusic Plugins Jan 09 20:03:05 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 09 20:03:12 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 09 20:03:12 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 09 20:03:12 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 20:03:12 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 20:03:12 volumio-4-home volumio[1206]: info: Starting MyVolumio Remote Streaming Endpoints Jan 09 20:03:12 volumio-4-home volumio[1206]: info: MyVolumio login type: Token Jan 09 20:03:12 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 09 20:03:12 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 09 20:03:18 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 09 20:03:18 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 09 20:03:18 volumio-4-home volumio[1206]: info: Streaming services startup Jan 09 20:03:18 volumio-4-home volumio[1206]: info: Starting Streaming Daemon Jan 09 20:03:18 volumio-4-home sudo[1673]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 09 20:03:18 volumio-4-home sudo[1673]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 09 20:03:18 volumio-4-home sudo[1673]: pam_unix(sudo:session): session closed for user root Jan 09 20:03:19 volumio-4-home volumio[1206]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jan 09 20:03:19 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 20:03:19 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 20:03:19 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 09 20:03:23 volumio-4-home volumio[1206]: error: Cannot start Volumio Streaming Daemon Jan 09 20:03:23 volumio-4-home volumio[1206]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 09 20:03:23 volumio-4-home volumio[1206]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 09 20:03:29 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 09 20:03:49 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:03:49 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:03:49 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 09 20:03:49 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 09 20:03:49 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 09 20:03:49 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 09 20:03:49 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumioGetBrowseSources Jan 09 20:03:49 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 20:03:50 volumio-4-home volumio[1206]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jan 09 20:03:50 volumio-4-home volumio[1206]: info: Completed starting MyVolumio Plugin Jan 09 20:03:50 volumio-4-home volumio[1206]: [Metrics] CommandRouter: 98s 68.64ms Jan 09 20:03:50 volumio-4-home volumio[1206]: info: CoreCommandRouter::volumiosetStartupVolume Jan 09 20:03:50 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 20:03:50 volumio-4-home volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 20:03:50 volumio-4-home volumio[1206]: info: CoreCommandRouter::Close All Modals sent Jan 09 20:03:50 volumio-4-home volumio[1206]: info: CoreCommandRouter::Close All Modals sent Jan 09 20:03:50 volumio-4-home volumio[1206]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jan 09 20:03:50 volumio-4-home volumio[1206]: info: Retrying Login Due to Network Error Jan 09 20:03:50 volumio-4-home volumio[1206]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 20:03:50 volumio-4-home volumio[1206]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. Jan 09 20:03:50 volumio-4-home volumio[1206]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues Jan 09 20:03:50 volumio-4-home volumio[1206]: at new NodeError (node:internal/errors:405:5) Jan 09 20:03:50 volumio-4-home volumio[1206]: at assert (node:internal/assert:14:11) Jan 09 20:03:50 volumio-4-home volumio[1206]: at internalConnectMultiple (node:net:1118:3) Jan 09 20:03:50 volumio-4-home volumio[1206]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Jan 09 20:03:50 volumio-4-home volumio[1206]: at listOnTimeout (node:internal/timers:575:11) Jan 09 20:03:50 volumio-4-home volumio[1206]: at process.processTimers (node:internal/timers:514:7) { Jan 09 20:03:50 volumio-4-home volumio[1206]: code: 'ERR_INTERNAL_ASSERTION' Jan 09 20:03:50 volumio-4-home volumio[1206]: } Jan 09 20:03:50 volumio-4-home volumio[1206]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 20:03:56 volumio-4-home sudo[1746]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-09 20:02' Jan 09 20:03:56 volumio-4-home sudo[1746]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"