-- Logs begin at Thu 2019-02-14 18:11:59 HKT, end at Thu 2025-10-30 19:34:26 HKT. -- Oct 30 19:33:56 volumio--pi systemd-timedated[1022]: Changed local time to Thu Oct 30 19:33:56 2025 Oct 30 19:33:56 volumio--pi sudo[1014]: pam_unix(sudo:session): session closed for user root Oct 30 19:33:56 volumio--pi volumio-time-update[630]: volumio-time-update-util: System time updated successfully. Oct 30 19:33:56 volumio--pi systemd[1]: Started Volumio Time Update Utility. Oct 30 19:33:56 volumio--pi systemd[1]: Starting Daily apt download activities... Oct 30 19:33:56 volumio--pi wireless.js[607]: trying... Oct 30 19:33:56 volumio--pi sudo[1026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 30 19:33:56 volumio--pi sudo[1026]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:33:56 volumio--pi sudo[1026]: pam_unix(sudo:session): session closed for user root Oct 30 19:33:57 volumio--pi wireless.js[607]: trying... Oct 30 19:33:57 volumio--pi sudo[1039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 30 19:33:57 volumio--pi sudo[1039]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:33:57 volumio--pi sudo[1039]: pam_unix(sudo:session): session closed for user root Oct 30 19:33:57 volumio--pi volumio-remote-updater[641]: [2025-10-30 19:33:57] [info] asio async_connect error: system:111 (Connection refused) Oct 30 19:33:57 volumio--pi volumio-remote-updater[641]: [2025-10-30 19:33:57] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 30 19:33:57 volumio--pi volumio-remote-updater[641]: [2025-10-30 19:33:57] [error] handle_connect error: Underlying Transport Error Oct 30 19:33:57 volumio--pi nmbd[759]: [2025/10/30 19:33:57.467270, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 30 19:33:57 volumio--pi nmbd[759]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.12 for name WORKGROUP<1d>. Oct 30 19:33:57 volumio--pi nmbd[759]: This response was from IP 192.168.0.33, reporting an IP address of 192.168.0.131. Oct 30 19:33:57 volumio--pi nmbd[759]: [2025/10/30 19:33:57.467641, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 30 19:33:57 volumio--pi nmbd[759]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.0.12 for name WORKGROUP<1d>. Oct 30 19:33:57 volumio--pi nmbd[759]: This response was from IP 192.168.0.33, reporting an IP address of 192.168.0.131. Oct 30 19:33:57 volumio--pi nmbd[759]: [2025/10/30 19:33:57.467883, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 30 19:33:57 volumio--pi nmbd[759]: query_name_response: Multiple (4) responses received for a query on subnet 192.168.0.12 for name WORKGROUP<1d>. Oct 30 19:33:57 volumio--pi nmbd[759]: This response was from IP 192.168.0.131, reporting an IP address of 192.168.0.131. Oct 30 19:33:57 volumio--pi nmbd[759]: [2025/10/30 19:33:57.468134, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 30 19:33:57 volumio--pi nmbd[759]: query_name_response: Multiple (5) responses received for a query on subnet 192.168.0.12 for name WORKGROUP<1d>. Oct 30 19:33:57 volumio--pi nmbd[759]: This response was from IP 192.168.0.131, reporting an IP address of 192.168.0.131. Oct 30 19:33:57 volumio--pi nmbd[759]: [2025/10/30 19:33:57.468429, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 30 19:33:57 volumio--pi nmbd[759]: query_name_response: Multiple (6) responses received for a query on subnet 192.168.0.12 for name WORKGROUP<1d>. Oct 30 19:33:57 volumio--pi nmbd[759]: This response was from IP 192.168.0.33, reporting an IP address of 192.168.0.131. Oct 30 19:33:57 volumio--pi nmbd[759]: [2025/10/30 19:33:57.469961, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 30 19:33:57 volumio--pi nmbd[759]: query_name_response: Multiple (7) responses received for a query on subnet 192.168.0.12 for name WORKGROUP<1d>. Oct 30 19:33:57 volumio--pi nmbd[759]: This response was from IP 192.168.0.33, reporting an IP address of 192.168.0.131. Oct 30 19:33:57 volumio--pi nmbd[759]: [2025/10/30 19:33:57.470282, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 30 19:33:57 volumio--pi nmbd[759]: query_name_response: Multiple (8) responses received for a query on subnet 192.168.0.12 for name WORKGROUP<1d>. Oct 30 19:33:57 volumio--pi nmbd[759]: This response was from IP 192.168.0.33, reporting an IP address of 192.168.0.131. Oct 30 19:33:57 volumio--pi nmbd[759]: [2025/10/30 19:33:57.470548, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 30 19:33:57 volumio--pi nmbd[759]: query_name_response: Multiple (9) responses received for a query on subnet 192.168.0.12 for name WORKGROUP<1d>. Oct 30 19:33:57 volumio--pi nmbd[759]: This response was from IP 192.168.0.131, reporting an IP address of 192.168.0.131. Oct 30 19:33:57 volumio--pi nmbd[759]: [2025/10/30 19:33:57.470757, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 30 19:33:57 volumio--pi nmbd[759]: query_name_response: Multiple (10) responses received for a query on subnet 192.168.0.12 for name WORKGROUP<1d>. Oct 30 19:33:57 volumio--pi nmbd[759]: This response was from IP 192.168.0.131, reporting an IP address of 192.168.0.131. Oct 30 19:33:57 volumio--pi nmbd[759]: [2025/10/30 19:33:57.471086, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 30 19:33:57 volumio--pi nmbd[759]: query_name_response: Multiple (11) responses received for a query on subnet 192.168.0.12 for name WORKGROUP<1d>. Oct 30 19:33:57 volumio--pi nmbd[759]: This response was from IP 192.168.0.33, reporting an IP address of 192.168.0.131. Oct 30 19:33:57 volumio--pi nmbd[759]: [2025/10/30 19:33:57.471296, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 30 19:33:57 volumio--pi nmbd[759]: query_name_response: Multiple (12) responses received for a query on subnet 192.168.0.12 for name WORKGROUP<1d>. Oct 30 19:33:57 volumio--pi nmbd[759]: This response was from IP 192.168.0.33, reporting an IP address of 192.168.0.131. Oct 30 19:33:57 volumio--pi smbd[1021]: [2025/10/30 19:33:57.540202, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 30 19:33:57 volumio--pi systemd[1]: Started Samba SMB Daemon. Oct 30 19:33:57 volumio--pi smbd[1021]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 30 19:33:58 volumio--pi wireless.js[607]: trying... Oct 30 19:33:58 volumio--pi sudo[1059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 30 19:33:58 volumio--pi sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:33:58 volumio--pi sudo[1059]: pam_unix(sudo:session): session closed for user root Oct 30 19:33:59 volumio--pi wireless.js[607]: trying... Oct 30 19:33:59 volumio--pi sudo[1062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 30 19:33:59 volumio--pi sudo[1062]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:33:59 volumio--pi sudo[1062]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:00 volumio--pi wireless.js[607]: trying... Oct 30 19:34:00 volumio--pi sudo[1075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 30 19:34:00 volumio--pi sudo[1075]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:00 volumio--pi sudo[1075]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:00 volumio--pi systemd[1]: apt-daily.service: Succeeded. Oct 30 19:34:00 volumio--pi systemd[1]: Started Daily apt download activities. Oct 30 19:34:00 volumio--pi dhcpcd[981]: wlan0: leased 192.168.0.130 for 3600 seconds Oct 30 19:34:00 volumio--pi avahi-daemon[629]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.130. Oct 30 19:34:00 volumio--pi dhcpcd[981]: wlan0: adding route to 192.168.0.0/24 Oct 30 19:34:00 volumio--pi dhcpcd[981]: wlan0: adding default route via 192.168.0.1 Oct 30 19:34:00 volumio--pi avahi-daemon[629]: New relevant interface wlan0.IPv4 for mDNS. Oct 30 19:34:00 volumio--pi avahi-daemon[629]: Registering new address record for 192.168.0.130 on wlan0.IPv4. Oct 30 19:34:00 volumio--pi systemd[1]: Starting Daily apt upgrade and clean activities... Oct 30 19:34:01 volumio--pi wireless.js[607]: trying... Oct 30 19:34:01 volumio--pi sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 30 19:34:01 volumio--pi sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:01 volumio--pi sudo[1136]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:01 volumio--pi wireless.js[607]: Connected to: ----Home Oct 30 19:34:01 volumio--pi wireless.js[607]: ---- Oct 30 19:34:01 volumio--pi sudo[1139]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 30 19:34:01 volumio--pi sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:01 volumio--pi sudo[1139]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:01 volumio--pi wireless.js[607]: ... joined AP, wlan0 IPv4 is 192.168.0.130, ipV6 is undefined Oct 30 19:34:01 volumio--pi wireless.js[607]: It's done! AP Oct 30 19:34:01 volumio--pi kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 30 19:34:01 volumio--pi systemd[1]: Started Wireless Services. Oct 30 19:34:01 volumio--pi systemd[1]: Started Volumio Backend Module. Oct 30 19:34:01 volumio--pi systemd[1]: Started Volumio Cpu Tweaker. Oct 30 19:34:01 volumio--pi systemd[1]: Reached target Multi-User System. Oct 30 19:34:01 volumio--pi systemd[1]: Reached target Graphical Interface. Oct 30 19:34:01 volumio--pi systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 30 19:34:01 volumio--pi systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 30 19:34:01 volumio--pi systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 30 19:34:01 volumio--pi volumio-cpu-tweak[1145]: Setting RT Priority for mpd Oct 30 19:34:01 volumio--pi volumio-cpu-tweak[1145]: Setting MPD Affinity Oct 30 19:34:01 volumio--pi volumio-cpu-tweak[1145]: pid 817's current affinity mask: f Oct 30 19:34:01 volumio--pi volumio-cpu-tweak[1145]: pid 817's new affinity mask: 3 Oct 30 19:34:01 volumio--pi volumio-cpu-tweak[1145]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Oct 30 19:34:01 volumio--pi volumio-cpu-tweak[1145]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Oct 30 19:34:01 volumio--pi systemd[1]: volumio_cpu_tweak.service: Succeeded. Oct 30 19:34:02 volumio--pi ntpd[793]: Listen normally on 4 wlan0 192.168.0.130:123 Oct 30 19:34:02 volumio--pi systemd[1]: apt-daily-upgrade.service: Succeeded. Oct 30 19:34:02 volumio--pi ntpd[793]: new interface(s) found: waking up resolver Oct 30 19:34:02 volumio--pi systemd[1]: Started Daily apt upgrade and clean activities. Oct 30 19:34:02 volumio--pi systemd[1]: Startup finished in 16.805s (kernel) + 25.988s (userspace) = 42.793s. Oct 30 19:34:04 volumio--pi volumio[1144]: info: ------------------------------------------- Oct 30 19:34:04 volumio--pi volumio[1144]: info: ----- Volumio3 ---- Oct 30 19:34:04 volumio--pi volumio[1144]: info: ------------------------------------------- Oct 30 19:34:04 volumio--pi volumio[1144]: info: ----- System startup ---- Oct 30 19:34:04 volumio--pi volumio[1144]: info: ------------------------------------------- Oct 30 19:34:05 volumio--pi volumio[1144]: info: MYVOLUMIO Environment detected Oct 30 19:34:05 volumio--pi volumio[1144]: info: Plugin folders cleanup Oct 30 19:34:05 volumio--pi volumio[1144]: info: Scanning into folder /volumio/app/plugins/ Oct 30 19:34:05 volumio--pi volumio[1144]: info: Scanning category audio_interface Oct 30 19:34:05 volumio--pi volumio[1144]: info: Scanning category miscellanea Oct 30 19:34:05 volumio--pi volumio[1144]: info: Scanning category music_service Oct 30 19:34:05 volumio--pi volumio[1144]: info: Scanning category plugins.json Oct 30 19:34:05 volumio--pi volumio[1144]: info: Scanning category system_controller Oct 30 19:34:05 volumio--pi volumio[1144]: info: Scanning category user_interface Oct 30 19:34:05 volumio--pi volumio[1144]: info: Scanning into folder /data/plugins/ Oct 30 19:34:05 volumio--pi volumio[1144]: info: Scanning category audio_interface Oct 30 19:34:05 volumio--pi volumio[1144]: info: Scanning category music_service Oct 30 19:34:05 volumio--pi volumio[1144]: info: Scanning category system_controller Oct 30 19:34:05 volumio--pi volumio[1144]: info: Plugin folders cleanup completed Oct 30 19:34:05 volumio--pi volumio[1144]: info: ------------------------------------------- Oct 30 19:34:05 volumio--pi volumio[1144]: info: ----- Core plugins startup ---- Oct 30 19:34:05 volumio--pi volumio[1144]: info: ------------------------------------------- Oct 30 19:34:05 volumio--pi volumio[1144]: info: Loading plugins from folder /volumio/app/plugins/ Oct 30 19:34:05 volumio--pi volumio[1144]: info: Adding plugin upnp to MyMusic Plugins Oct 30 19:34:05 volumio--pi volumio[1144]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 30 19:34:05 volumio--pi volumio[1144]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 30 19:34:05 volumio--pi volumio[1144]: info: Loading plugins from folder /data/plugins/ Oct 30 19:34:05 volumio--pi volumio[1144]: info: Loading plugin "system"... Oct 30 19:34:05 volumio--pi volumio[1144]: info: Loading plugin "appearance"... Oct 30 19:34:07 volumio--pi volumio-remote-updater[641]: [2025-10-30 19:34:07] [connect] Successful connection Oct 30 19:34:07 volumio--pi volumio[1144]: info: Loading plugin "network"... Oct 30 19:34:07 volumio--pi volumio[1144]: info: Refreshing Cached IP Addresses Oct 30 19:34:07 volumio--pi sudo[1205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 30 19:34:07 volumio--pi sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:07 volumio--pi sudo[1205]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:07 volumio--pi sudo[1207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 30 19:34:07 volumio--pi sudo[1207]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:07 volumio--pi sudo[1207]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:07 volumio--pi volumio[1144]: info: Loading plugin "services"... Oct 30 19:34:07 volumio--pi volumio[1144]: info: Loading plugin "alsa_controller"... Oct 30 19:34:07 volumio--pi sudo[1216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 30 19:34:07 volumio--pi sudo[1216]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:07 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 30 19:34:07 volumio--pi volumio[1144]: info: Loading plugin "wizard"... Oct 30 19:34:07 volumio--pi volumio[1144]: info: Loading plugin "networkfs"... Oct 30 19:34:07 volumio--pi volumio[1144]: info: Starting Udev Watcher for removable devices Oct 30 19:34:07 volumio--pi sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=york,password=Sp25086441,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.33/Music /mnt/NAS/Songs_on_HP Oct 30 19:34:07 volumio--pi sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:07 volumio--pi volumio[1144]: info: Ignoring mount for partition: boot Oct 30 19:34:07 volumio--pi volumio[1144]: info: Ignoring mount for partition: volumio Oct 30 19:34:07 volumio--pi volumio[1144]: info: Ignoring mount for partition: volumio_data Oct 30 19:34:07 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 30 19:34:07 volumio--pi volumio[1144]: info: Loading plugin "volumio_command_line_client"... Oct 30 19:34:07 volumio--pi volumio[1144]: info: Loading plugin "upnp"... Oct 30 19:34:07 volumio--pi volumio[1144]: info: [1761824047728] Starting Upmpd Daemon Oct 30 19:34:07 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 30 19:34:07 volumio--pi volumio[1144]: info: Loading plugin "my_music"... Oct 30 19:34:07 volumio--pi volumio[1144]: info: Loading plugin "mpd"... Oct 30 19:34:07 volumio--pi kernel: Key type cifs.spnego registered Oct 30 19:34:07 volumio--pi kernel: Key type cifs.idmap registered Oct 30 19:34:07 volumio--pi kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Oct 30 19:34:07 volumio--pi kernel: CIFS: Attempting to mount //192.168.0.33/Music Oct 30 19:34:08 volumio--pi sudo[1216]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:08 volumio--pi volumio[1144]: info: Loading plugin "upnp_browser"... Oct 30 19:34:08 volumio--pi volumio[1144]: info: Loading plugin "alarm-clock"... Oct 30 19:34:08 volumio--pi volumio[1144]: info: Loading plugin "airplay_emulation"... Oct 30 19:34:09 volumio--pi volumio[1144]: info: Starting Shairport Sync Oct 30 19:34:09 volumio--pi volumio[1144]: info: Loading plugin "last_100"... Oct 30 19:34:09 volumio--pi kernel: cryptd: max_cpu_qlen set to 1000 Oct 30 19:34:09 volumio--pi volumio[1144]: info: Loading plugin "webradio"... Oct 30 19:34:09 volumio--pi volumio[1144]: info: Loading plugin "i2s_dacs"... Oct 30 19:34:09 volumio--pi volumio[1144]: info: I2S DAC not set, start Auto-detection Oct 30 19:34:09 volumio--pi volumio[1144]: info: Loading plugin "volumiodiscovery"... Oct 30 19:34:09 volumio--pi volumio[1144]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 30 19:34:09 volumio--pi volumio[1144]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 30 19:34:09 volumio--pi volumio[1144]: *** WARNING *** For more information see Oct 30 19:34:09 volumio--pi volumio[1144]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 30 19:34:09 volumio--pi volumio[1144]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 30 19:34:09 volumio--pi volumio[1144]: *** WARNING *** For more information see Oct 30 19:34:09 volumio--pi node[1144]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 30 19:34:09 volumio--pi node[1144]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 30 19:34:09 volumio--pi node[1144]: *** WARNING *** For more information see Oct 30 19:34:09 volumio--pi node[1144]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 30 19:34:09 volumio--pi node[1144]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 30 19:34:09 volumio--pi node[1144]: *** WARNING *** For more information see Oct 30 19:34:09 volumio--pi volumio[1144]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 30 19:34:09 volumio--pi volumio[1144]: info: Discovery: Started advertising with name: Volumio -Pi Oct 30 19:34:09 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 30 19:34:09 volumio--pi volumio[1144]: info: Loading plugin "squeezelite_mc"... Oct 30 19:34:09 volumio--pi sudo[1233]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:10 volumio--pi systemd[1]: systemd-fsckd.service: Succeeded. Oct 30 19:34:10 volumio--pi volumio[1144]: info: Loading plugin "youtube2"... Oct 30 19:34:12 volumio--pi volumio[1144]: info: Loading plugin "ytcr"... Oct 30 19:34:16 volumio--pi volumio[1144]: info: Loading plugin "outputs"... Oct 30 19:34:16 volumio--pi volumio[1144]: info: Loading plugin "albumart"... Oct 30 19:34:16 volumio--pi volumio[1144]: info: Plugin example_plugin is not enabled Oct 30 19:34:16 volumio--pi volumio[1144]: info: Loading plugin "inputs"... Oct 30 19:34:16 volumio--pi volumio[1144]: info: Loading plugin "updater_comm"... Oct 30 19:34:16 volumio--pi volumio[1144]: info: Plugin mpdemulation is not enabled Oct 30 19:34:16 volumio--pi volumio[1144]: info: Loading plugin "rest_api"... Oct 30 19:34:16 volumio--pi volumio[1144]: info: Loading plugin "websocket"... Oct 30 19:34:16 volumio--pi volumio[1144]: info: Starting Socket.io Server version 2.3.0 Oct 30 19:34:16 volumio--pi volumio[1144]: info: Loading plugin "fusiondsp"... Oct 30 19:34:16 volumio--pi volumio[1144]: Forking 3 albumart workers Oct 30 19:34:17 volumio--pi volumio[1144]: info: Applying required configuration parameters for plugin fusiondsp Oct 30 19:34:17 volumio--pi volumio[1144]: info: Plugin mpdoutput is not enabled Oct 30 19:34:17 volumio--pi volumio[1144]: info: Plugin lms is not enabled Oct 30 19:34:17 volumio--pi volumio[1144]: info: Loading plugin "minidlna"... Oct 30 19:34:17 volumio--pi volumio[1144]: info: Applying required configuration parameters for plugin minidlna Oct 30 19:34:17 volumio--pi volumio[1144]: Starting albumart workers Oct 30 19:34:17 volumio--pi volumio[1144]: Starting albumart workers Oct 30 19:34:17 volumio--pi volumio[1144]: Starting albumart workers Oct 30 19:34:17 volumio--pi volumio[1144]: info: Loading plugin "backup_restore"... Oct 30 19:34:18 volumio--pi systemd[1]: systemd-hostnamed.service: Succeeded. Oct 30 19:34:18 volumio--pi volumio[1144]: info: Applying required configuration parameters for plugin backup_restore Oct 30 19:34:18 volumio--pi volumio[1144]: info: Loading i18n strings for locale en Oct 30 19:34:18 volumio--pi volumio[1144]: Updating browse sources language Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::initPlayerControls Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 30 19:34:18 volumio--pi volumio[1144]: Express server listening on port 3000 Oct 30 19:34:18 volumio--pi volumio[1144]: [Metrics] WebUI: 15s 478.31ms Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreStateMachine::resetVolumioState Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreStateMachine::getcurrentVolume Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioRetrievevolume Oct 30 19:34:18 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 19:34:18 volumio--pi sudo[1349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 30 19:34:18 volumio--pi sudo[1349]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:18 volumio--pi sudo[1349]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:18 volumio--pi sudo[1351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 30 19:34:18 volumio--pi sudo[1351]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:18 volumio--pi sudo[1351]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:18 volumio--pi volumio[1144]: info: Volumio Network Manager: Network status updated: 3 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 20 Oct 30 19:34:19 volumio--pi volumio[1144]: info: VolumeController:: Volume=86 Mute =false Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreStateMachine::pushState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioPushState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreStateMachine::updateTrackBlock Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getTrackBlock Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioRetrievevolume Oct 30 19:34:19 volumio--pi volumio[1144]: info: Reloading queue from file Oct 30 19:34:19 volumio--pi volumio[1144]: info: Setting Device type: Raspberry PI Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreStateMachine::setRepeat null single undefined Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreStateMachine::pushState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioPushState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreStateMachine::setRandom null Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreStateMachine::pushState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioPushState Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 21 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 22 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 23 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 24 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 25 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 26 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.12 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 27 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 28 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 29 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 30 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 31 Oct 30 19:34:19 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 192.168.0.130 from 192.168.0.126 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 32 Oct 30 19:34:19 volumio--pi volumio[1144]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Oct 30 19:34:19 volumio--pi volumio[1144]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082 Oct 30 19:34:19 volumio--pi volumio[1144]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Oct 30 19:34:19 volumio--pi sudo[1364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 30 19:34:19 volumio--pi sudo[1364]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:19 volumio--pi volumio[1144]: info: VolumeController:: Volume=86 Mute =false Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreStateMachine::pushState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioPushState Oct 30 19:34:19 volumio--pi volumio[1144]: info: Received Get System Info Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 19:34:19 volumio--pi volumio[1144]: info: Discovery: Getting this device information Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioGetState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioGetState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioGetVisibleSources Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioGetState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 30 19:34:19 volumio--pi volumio[1144]: info: Received Get System Info Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 19:34:19 volumio--pi volumio[1144]: info: Discovery: Getting this device information Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioGetState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioGetState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:19 volumio--pi systemd[1]: Started UPnP Renderer front-end to MPD. Oct 30 19:34:19 volumio--pi volumio[1144]: info: Listing playlists Oct 30 19:34:19 volumio--pi sudo[1364]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioGetQueue Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreStateMachine::getQueue Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getQueue Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 30 19:34:19 volumio--pi volumio[1144]: info: Discovery: adding 7695e705-009b-40a8-bc09-0cec236f5e6a Oct 30 19:34:19 volumio--pi volumio[1144]: info: Discovery: Found device Volumio -Pi Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioGetState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:19 volumio--pi volumio[1144]: info: Discovery: this is already registered, 7695e705-009b-40a8-bc09-0cec236f5e6a Oct 30 19:34:19 volumio--pi volumio[1144]: info: Discovery: Found device Volumio -Pi Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioGetState Oct 30 19:34:19 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:19 volumio--pi volumio[1144]: info: Upmpdcli Daemon Started Oct 30 19:34:19 volumio--pi volumio[1144]: info: Completed loading Core Plugins Oct 30 19:34:19 volumio--pi volumio[1144]: info: Preparing to generate the ALSA configuration file Oct 30 19:34:19 volumio--pi volumio[1144]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 30 19:34:19 volumio--pi volumio[1144]: info: Reading ALSA contributions from plugins. Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 30 19:34:19 volumio--pi volumio[1144]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 30 19:34:19 volumio--pi volumio[1144]: info: FusionDsp - Oct 30 19:34:20 volumio--pi volumio[1144]: info: FusionDsp - Oct 30 19:34:20 volumio--pi volumio[1144]: info: FusionDsp - Oct 30 19:34:20 volumio--pi volumio[1144]: info: FusionDsp - undefined Oct 30 19:34:20 volumio--pi volumio[1144]: info: FusionDsp - undefined Oct 30 19:34:20 volumio--pi volumio[1144]: info: FusionDsp - undefined Oct 30 19:34:20 volumio--pi volumio[1144]: info: FusionDsp - Oct 30 19:34:20 volumio--pi volumio[1366]: Generating RSA private key, 4096 bit long modulus (2 primes) Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 30 19:34:21 volumio--pi volumio[1144]: info: FusionDsp - undefined Oct 30 19:34:21 volumio--pi volumio[1144]: info: Asound.conf file unchanged, so no further update is needed Oct 30 19:34:21 volumio--pi volumio[1144]: info: Output device has changed, restarting MPD Oct 30 19:34:21 volumio--pi sudo[1383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 30 19:34:21 volumio--pi sudo[1383]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:21 volumio--pi volumio[1144]: info: Output device has changed, restarting Shairport Sync Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 19:34:21 volumio--pi sudo[1383]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:21 volumio--pi sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 30 19:34:21 volumio--pi sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:21 volumio--pi systemd[1]: Stopping Music Player Daemon... Oct 30 19:34:21 volumio--pi volumio[1144]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 30 19:34:21 volumio--pi volumio[1144]: info: ___________ START PLUGINS ___________ Oct 30 19:34:21 volumio--pi volumio[1144]: info: ControllerMpd::onStart: Initializing MPD Oct 30 19:34:21 volumio--pi volumio[1144]: info: Creating MPD Configuration file Oct 30 19:34:21 volumio--pi sudo[1392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 30 19:34:21 volumio--pi sudo[1392]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 30 19:34:21 volumio--pi sudo[1392]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:21 volumio--pi volumio[1144]: info: [1761824061410] CoreMusicLibrary::Adding element Media Servers Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 19:34:21 volumio--pi sudo[1394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 30 19:34:21 volumio--pi sudo[1394]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:21 volumio--pi systemd[1]: mpd.service: Succeeded. Oct 30 19:34:21 volumio--pi systemd[1]: Stopped Music Player Daemon. Oct 30 19:34:21 volumio--pi volumio[1144]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 19:34:21 volumio--pi systemd[1]: Starting Music Player Daemon... Oct 30 19:34:21 volumio--pi volumio[1144]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 30 19:34:21 volumio--pi volumio[1144]: info: [1761824061616] CoreMusicLibrary::Adding element Last_100 Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 30 19:34:21 volumio--pi volumio[1144]: info: [1761824061621] CoreMusicLibrary::Adding element Webradio Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 30 19:34:21 volumio--pi volumio[1144]: info: Initializing BBC Radios Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 19:34:21 volumio--pi sudo[1400]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 30 19:34:21 volumio--pi sudo[1400]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:21 volumio--pi sudo[1400]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:21 volumio--pi volumio[1144]: info: [squeezelite_mc] Starting proxy server... Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 30 19:34:21 volumio--pi volumio[1144]: info: [1761824061757] CoreMusicLibrary::Adding element YouTube2 Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 30 19:34:21 volumio--pi volumio[1144]: Cannot find translation for source YouTube2 Oct 30 19:34:21 volumio--pi volumio[1144]: info: Loading i18n strings for locale en Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 30 19:34:21 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:21 volumio--pi volumio[1144]: info: FusionDsp - mixtype--------------------- Hardware Oct 30 19:34:21 volumio--pi volumio[1144]: info: Loading i18n strings for locale en Oct 30 19:34:21 volumio--pi volumio[1144]: info: Volumio Calling Home Oct 30 19:34:22 volumio--pi volumio[1144]: info: [squeezelite_mc] Proxy server started on port 44539 Oct 30 19:34:22 volumio--pi volumio[1144]: info: Preparing to generate the ALSA configuration file Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioRetrievevolume Oct 30 19:34:22 volumio--pi volumio-remote-updater[641]: [2025-10-30 19:34:22] [connect] Successful connection Oct 30 19:34:22 volumio--pi volumio[1144]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 30 19:34:22 volumio--pi volumio[1144]: info: Reading ALSA contributions from plugins. Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 30 19:34:22 volumio--pi volumio[1144]: info: MPD Permissions set Oct 30 19:34:22 volumio--pi volumio[1144]: info: MPD Permissions set Oct 30 19:34:22 volumio--pi volumio-remote-updater[641]: [2025-10-30 19:34:22] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1761824062 101 Oct 30 19:34:22 volumio--pi volumio[1144]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 33 Oct 30 19:34:22 volumio--pi volumio[1144]: info: minidlna: Found miniDLNA version 1.2.1 Oct 30 19:34:22 volumio--pi volumio[1144]: info: minidlna: Starting minidlna.service Oct 30 19:34:22 volumio--pi sudo[1424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Oct 30 19:34:22 volumio--pi sudo[1424]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:22 volumio--pi volumio[1144]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 34 Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 30 19:34:22 volumio--pi volumio[1144]: info: VolumeController:: Volume=86 Mute =false Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioGetState Oct 30 19:34:22 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreStateMachine::pushState Oct 30 19:34:22 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioPushState Oct 30 19:34:22 volumio--pi volumio[1144]: info: [squeezelite_mc] Server discovery started Oct 30 19:34:22 volumio--pi volumio[1144]: info: [squeezelite_mc] Player finder started Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 30 19:34:22 volumio--pi volumio[1144]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Oct 30 19:34:22 volumio--pi systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Oct 30 19:34:22 volumio--pi sudo[1424]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:22 volumio--pi volumio[1144]: info: Volumio called home Oct 30 19:34:22 volumio--pi volumio[1144]: info: [squeezelite_mc] Card 5 supports the following ALSA formats: ["S16_LE","S32_LE","SPECIAL","DSD_U32_BE"] Oct 30 19:34:22 volumio--pi volumio[1144]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"basic","playerName":"volumio--pi","dsdFormat":"DSD_U32_BE","card":"5","mixerType":"Hardware","mixer":"HU300 HiFi 2.0 "} Oct 30 19:34:22 volumio--pi volumio[1144]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Oct 30 19:34:22 volumio--pi volumio[1144]: info: minidlna: systemctl start minidlna.service succeeded. Oct 30 19:34:22 volumio--pi volumio[1144]: info: Starting Shairport Sync Oct 30 19:34:22 volumio--pi volumio[1144]: info: Starting Shairport Sync Oct 30 19:34:22 volumio--pi sudo[1441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 30 19:34:22 volumio--pi sudo[1441]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:22 volumio--pi volumio[1144]: info: Starting Shairport Sync Oct 30 19:34:23 volumio--pi sudo[1446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 30 19:34:23 volumio--pi sudo[1446]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:23 volumio--pi sudo[1444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 30 19:34:23 volumio--pi sudo[1444]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:23 volumio--pi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 30 19:34:23 volumio--pi systemd[1]: shairport-sync.service: Succeeded. Oct 30 19:34:23 volumio--pi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::volumioGetState Oct 30 19:34:23 volumio--pi volumio[1144]: info: CorePlayQueue::getTrack 0 Oct 30 19:34:23 volumio--pi sudo[1439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 30 19:34:23 volumio--pi sudo[1439]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:23 volumio--pi sudo[1439]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:23 volumio--pi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 30 19:34:23 volumio--pi volumio[1144]: info: [squeezelite_mc] Executing alsactl -L -R nrestore Oct 30 19:34:23 volumio--pi sudo[1441]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:23 volumio--pi sudo[1444]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:23 volumio--pi sudo[1446]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:23 volumio--pi volumio[1144]: info: Asound.conf file unchanged, so no further update is needed Oct 30 19:34:23 volumio--pi volumio[1144]: info: Output device has changed, restarting MPD Oct 30 19:34:23 volumio--pi sudo[1454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore Oct 30 19:34:23 volumio--pi sudo[1454]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:23 volumio--pi volumio[1144]: info: Output device has changed, restarting Shairport Sync Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 19:34:23 volumio--pi sudo[1458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 30 19:34:23 volumio--pi sudo[1461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 30 19:34:23 volumio--pi sudo[1461]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:23 volumio--pi sudo[1458]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:23 volumio--pi sudo[1458]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:23 volumio--pi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 30 19:34:23 volumio--pi systemd[1]: mpd.service: Succeeded. Oct 30 19:34:23 volumio--pi systemd[1]: Stopped Music Player Daemon. Oct 30 19:34:23 volumio--pi sudo[1454]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:23 volumio--pi volumio[1144]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 30 19:34:23 volumio--pi systemd[1]: Starting Music Player Daemon... Oct 30 19:34:23 volumio--pi volumio[1144]: info: Shairport-Sync Started Oct 30 19:34:23 volumio--pi volumio[1144]: Error adding Membership: Error: addMembership EINVAL Oct 30 19:34:23 volumio--pi volumio[1144]: info: Shairport-Sync Started Oct 30 19:34:23 volumio--pi volumio[1144]: info: MPD Permissions set Oct 30 19:34:23 volumio--pi volumio[1144]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Oct 30 19:34:23 volumio--pi sudo[1467]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 30 19:34:23 volumio--pi sudo[1467]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 30 19:34:23 volumio--pi sudo[1467]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 19:34:23 volumio--pi sudo[1473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Oct 30 19:34:23 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:23 volumio--pi sudo[1473]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:23 volumio--pi sudo[1473]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:23 volumio--pi volumio[1144]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true Oct 30 19:34:23 volumio--pi sudo[1482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Oct 30 19:34:23 volumio--pi sudo[1482]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:23 volumio--pi volumio[1144]: info: Starting Shairport Sync Oct 30 19:34:23 volumio--pi systemd[1]: Reloading. Oct 30 19:34:23 volumio--pi sudo[1485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 30 19:34:23 volumio--pi sudo[1485]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:24 volumio--pi volumio[1144]: info: camilladsp service started and running in background, instance 1 Oct 30 19:34:24 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 19:34:25 volumio--pi volumio[1144]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 30 19:34:25 volumio--pi volumio[1144]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Oct 30 19:34:25 volumio--pi volumio[1144]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 30 19:34:25 volumio--pi volumio[1144]: info: FusionDsp loaded Oct 30 19:34:25 volumio--pi volumio[1144]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 19:34:25 volumio--pi mpd[1475]: Oct 30 19:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 30 19:34:25 volumio--pi sudo[1510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 30 19:34:25 volumio--pi sudo[1510]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:25 volumio--pi volumio[1144]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 30 19:34:25 volumio--pi volumio[1144]: info: Adding Signal Path Element [object Object] Oct 30 19:34:25 volumio--pi volumio[1144]: info: Adding fusiondspeq DSP Signal Path Element Oct 30 19:34:25 volumio--pi volumio[1144]: info: FusionDsp - ---- installed callbackRead Oct 30 19:34:25 volumio--pi volumio[1144]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 19:34:25 volumio--pi volumio[1144]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Oct 30 19:34:25 volumio--pi volumio[1144]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Oct 30 19:34:25 volumio--pi volumio[1144]: at onErrorNT (internal/child_process.js:465:16) Oct 30 19:34:25 volumio--pi volumio[1144]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Oct 30 19:34:25 volumio--pi volumio[1144]: errno: -2, Oct 30 19:34:25 volumio--pi volumio[1144]: code: 'ENOENT', Oct 30 19:34:25 volumio--pi volumio[1144]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Oct 30 19:34:25 volumio--pi volumio[1144]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Oct 30 19:34:25 volumio--pi volumio[1144]: spawnargs: [ Oct 30 19:34:25 volumio--pi volumio[1144]: '-p', Oct 30 19:34:25 volumio--pi volumio[1144]: 9876, Oct 30 19:34:25 volumio--pi volumio[1144]: '-o', Oct 30 19:34:25 volumio--pi volumio[1144]: '/tmp/camilladsp.log', Oct 30 19:34:25 volumio--pi volumio[1144]: '-l', Oct 30 19:34:25 volumio--pi volumio[1144]: 'warn', Oct 30 19:34:25 volumio--pi volumio[1144]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Oct 30 19:34:25 volumio--pi volumio[1144]: ] Oct 30 19:34:25 volumio--pi volumio[1144]: } Oct 30 19:34:25 volumio--pi volumio[1144]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 19:34:25 volumio--pi systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Oct 30 19:34:25 volumio--pi systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Oct 30 19:34:25 volumio--pi systemd[1]: Started Music Player Daemon. Oct 30 19:34:25 volumio--pi sudo[1482]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:25 volumio--pi sudo[1461]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:25 volumio--pi sudo[1394]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:25 volumio--pi sudo[1385]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:26 volumio--pi sudo[1526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-30 19:33 Oct 30 19:34:26 volumio--pi sudo[1526]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 19:34:26 volumio--pi systemd[1]: Started FusionDsp Daemon. Oct 30 19:34:26 volumio--pi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 30 19:34:26 volumio--pi systemd[1]: systemd-timedated.service: Succeeded. Oct 30 19:34:26 volumio--pi systemd[1]: shairport-sync.service: Succeeded. Oct 30 19:34:26 volumio--pi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 30 19:34:26 volumio--pi sudo[1510]: pam_unix(sudo:session): session closed for user root Oct 30 19:34:26 volumio--pi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 30 19:34:26 volumio--pi sudo[1485]: pam_unix(sudo:session): session closed for user root PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"