Dec 26 16:54:00 volumiofranceule dhcpcd[810]: wlan0: leased 192.168.1.32 for infinity Dec 26 16:54:00 volumiofranceule avahi-daemon[719]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.32. Dec 26 16:54:00 volumiofranceule avahi-daemon[719]: New relevant interface wlan0.IPv4 for mDNS. Dec 26 16:54:00 volumiofranceule avahi-daemon[719]: Registering new address record for 192.168.1.32 on wlan0.IPv4. Dec 26 16:54:00 volumiofranceule dhcpcd[810]: wlan0: adding route to 192.168.1.0/24 Dec 26 16:54:00 volumiofranceule dhcpcd[810]: wlan0: adding default route via 192.168.1.1 Dec 26 16:54:00 volumiofranceule wireless.js[759]: WIRELESS.JS: trying... Dec 26 16:54:00 volumiofranceule systemd[1]: Started nmbd.service - Samba NMB Daemon. Dec 26 16:54:00 volumiofranceule sudo[1267]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 16:54:00 volumiofranceule sudo[1267]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:54:00 volumiofranceule sudo[1267]: pam_unix(sudo:session): session closed for user root Dec 26 16:54:00 volumiofranceule wireless.js[759]: WIRELESS.JS: Connected to: ----franceule---- Dec 26 16:54:00 volumiofranceule systemd[1]: Starting winbind.service - Samba Winbind Daemon... Dec 26 16:54:00 volumiofranceule systemd[1]: welcome.service: Deactivated successfully. Dec 26 16:54:00 volumiofranceule systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 26 16:54:00 volumiofranceule systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 26 16:54:00 volumiofranceule systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 26 16:54:00 volumiofranceule welcome[1291]: Resolved ip:[1] 192.168.1.32 Dec 26 16:54:00 volumiofranceule sudo[1289]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 16:54:00 volumiofranceule sudo[1289]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:54:00 volumiofranceule sudo[1289]: pam_unix(sudo:session): session closed for user root Dec 26 16:54:00 volumiofranceule wireless.js[759]: WIRELESS.JS: ... joined AP, wlan0 IPv4 is 192.168.1.32, ipV6 is undefined Dec 26 16:54:00 volumiofranceule wireless.js[759]: WIRELESS.JS: It's done! AP Dec 26 16:54:00 volumiofranceule wireless.js[759]: WIRELESS.JS: Restarting avahi-daemon... Dec 26 16:54:00 volumiofranceule systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 26 16:54:00 volumiofranceule systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 26 16:54:00 volumiofranceule systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 26 16:54:00 volumiofranceule systemd[1]: shairport-sync.service: Deactivated successfully. Dec 26 16:54:00 volumiofranceule systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:54:00 volumiofranceule systemd[1]: shairport-sync.service: Consumed 1.691s CPU time. Dec 26 16:54:00 volumiofranceule avahi-daemon[719]: Got SIGTERM, quitting. Dec 26 16:54:00 volumiofranceule avahi-daemon[719]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.32. Dec 26 16:54:00 volumiofranceule systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Dec 26 16:54:00 volumiofranceule avahi-daemon[719]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Dec 26 16:54:00 volumiofranceule avahi-daemon[719]: avahi-daemon 0.8 exiting. Dec 26 16:54:00 volumiofranceule systemd[1]: avahi-daemon.service: Deactivated successfully. Dec 26 16:54:00 volumiofranceule systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Dec 26 16:54:00 volumiofranceule wireless.js[759]: WIRELESS.JS: Notified systemd about wireless ready Dec 26 16:54:00 volumiofranceule systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Dec 26 16:54:00 volumiofranceule iwconfig[1305]: Error for wireless request "Set Power Management" (8B2C) : Dec 26 16:54:00 volumiofranceule iwconfig[1305]: SET failed on device wlan0 ; Operation not supported. Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: Process 719 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Dec 26 16:54:00 volumiofranceule systemd[1]: Started wireless.service - Wireless Services. Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: Successfully dropped root privileges. Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: avahi-daemon 0.8 starting up. Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: Successfully called chroot(). Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: Successfully dropped remaining capabilities. Dec 26 16:54:00 volumiofranceule systemd[1]: Started volumio.service - Volumio Backend Module. Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: Loading service file /services/volumio.service. Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.32. Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: New relevant interface wlan0.IPv4 for mDNS. Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: New relevant interface lo.IPv4 for mDNS. Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: Network interface enumeration completed. Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: Registering new address record for 192.168.1.32 on wlan0.IPv4. Dec 26 16:54:00 volumiofranceule avahi-daemon[1304]: Registering new address record for 127.0.0.1 on lo.IPv4. Dec 26 16:54:00 volumiofranceule systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... Dec 26 16:54:00 volumiofranceule systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. Dec 26 16:54:00 volumiofranceule systemd[1]: Received SIGRTMIN+21 from PID 322 (plymouthd). Dec 26 16:54:00 volumiofranceule systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Dec 26 16:54:00 volumiofranceule systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. Dec 26 16:54:00 volumiofranceule systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. Dec 26 16:54:00 volumiofranceule systemd[1]: Received SIGRTMIN+21 from PID 322 (n/a). Dec 26 16:54:00 volumiofranceule systemd[1]: Started getty@tty1.service - Getty on tty1. Dec 26 16:54:00 volumiofranceule systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Dec 26 16:54:00 volumiofranceule systemd[1]: Reached target getty.target - Login Prompts. Dec 26 16:54:00 volumiofranceule systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:54:00 volumiofranceule volumio-cpu-tweak[1309]: Setting RT Priority for mpd Dec 26 16:54:00 volumiofranceule volumio-cpu-tweak[1326]: pid 35's current scheduling policy: SCHED_OTHER Dec 26 16:54:00 volumiofranceule volumio-cpu-tweak[1326]: pid 35's current scheduling priority: 0 Dec 26 16:54:00 volumiofranceule volumio-cpu-tweak[1309]: Setting MPD Affinity Dec 26 16:54:00 volumiofranceule volumio-cpu-tweak[1327]: pid 3's current affinity mask: f Dec 26 16:54:00 volumiofranceule volumio-cpu-tweak[1309]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Dec 26 16:54:00 volumiofranceule volumio-cpu-tweak[1309]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Dec 26 16:54:00 volumiofranceule systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. Dec 26 16:54:00 volumiofranceule winbindd[1301]: [2025/12/26 16:54:00.710825, 0] ../../source3/winbindd/winbindd.c:1440(main) Dec 26 16:54:00 volumiofranceule winbindd[1301]: winbindd version 4.17.8-Raspbian started. Dec 26 16:54:00 volumiofranceule winbindd[1301]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Dec 26 16:54:00 volumiofranceule winbindd[1301]: [2025/12/26 16:54:00.733359, 0] ../../source3/winbindd/winbindd_cache.c:3116(initialize_winbindd_cache) Dec 26 16:54:00 volumiofranceule winbindd[1301]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 26 16:54:00 volumiofranceule systemd[1]: Started winbind.service - Samba Winbind Daemon. Dec 26 16:54:00 volumiofranceule systemd[1]: Starting smbd.service - Samba SMB Daemon... Dec 26 16:54:01 volumiofranceule smbd[1352]: [2025/12/26 16:54:01.299543, 0] ../../source3/smbd/server.c:1741(main) Dec 26 16:54:01 volumiofranceule smbd[1352]: smbd version 4.17.8-Raspbian started. Dec 26 16:54:01 volumiofranceule smbd[1352]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Dec 26 16:54:01 volumiofranceule ntpd[968]: IO: Listen normally on 3 wlan0 192.168.1.32:123 Dec 26 16:54:01 volumiofranceule ntpd[968]: IO: new interface(s) found: waking up resolver Dec 26 16:54:01 volumiofranceule ntpd[968]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 26 16:54:01 volumiofranceule avahi-daemon[1304]: Server startup complete. Host name is volumiofranceule.local. Local service cookie is 3895908096. Dec 26 16:54:01 volumiofranceule ntpd[968]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Dec 26 16:54:01 volumiofranceule ntpd[968]: DNS: Pool taking: 82.67.41.119 Dec 26 16:54:01 volumiofranceule ntpd[968]: DNS: Pool taking: 79.143.250.33 Dec 26 16:54:01 volumiofranceule ntpd[968]: DNS: Pool taking: 172.232.63.219 Dec 26 16:54:01 volumiofranceule ntpd[968]: DNS: Pool taking: 82.66.40.79 Dec 26 16:54:01 volumiofranceule ntpd[968]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Dec 26 16:54:02 volumiofranceule ntpd[968]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 26 16:54:02 volumiofranceule avahi-daemon[1304]: Service "VolumioFranceule" (/services/volumio.service) successfully established. Dec 26 16:54:02 volumiofranceule ntpd[968]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Dec 26 16:54:02 volumiofranceule ntpd[968]: DNS: Pool skipping: 79.143.250.33 Dec 26 16:54:02 volumiofranceule ntpd[968]: DNS: Pool taking: 31.58.102.164 Dec 26 16:54:02 volumiofranceule ntpd[968]: DNS: Pool taking: 38.242.218.253 Dec 26 16:54:02 volumiofranceule ntpd[968]: DNS: Pool taking: 82.64.81.218 Dec 26 16:54:02 volumiofranceule ntpd[968]: DNS: Pool taking: 2607:ff68:14:11::e539:b04a Dec 26 16:54:02 volumiofranceule ntpd[968]: DNS: Pool taking: 2a01:cb00:129e:a803::2ab Dec 26 16:54:02 volumiofranceule ntpd[968]: DNS: Pool taking: 2a01:cb00:129e:a803::104 Dec 26 16:54:02 volumiofranceule ntpd[968]: DNS: Pool taking: 2a06:e881:7000::d0a:29ac Dec 26 16:54:02 volumiofranceule ntpd[968]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Dec 26 16:54:02 volumiofranceule systemd[1]: Started smbd.service - Samba SMB Daemon. Dec 26 16:54:02 volumiofranceule systemd[1]: Reached target multi-user.target - Multi-User System. Dec 26 16:54:02 volumiofranceule systemd[1]: Reached target graphical.target - Graphical Interface. Dec 26 16:54:02 volumiofranceule systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Dec 26 16:54:02 volumiofranceule systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Dec 26 16:54:02 volumiofranceule systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Dec 26 16:54:02 volumiofranceule systemd[1]: Startup finished in 13.239s (kernel) + 20.653s (userspace) = 33.892s. Dec 26 16:54:03 volumiofranceule ntpd[968]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 26 16:54:03 volumiofranceule ntpd[968]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Dec 26 16:54:03 volumiofranceule ntpd[968]: DNS: Pool taking: 194.57.169.1 Dec 26 16:54:03 volumiofranceule ntpd[968]: DNS: Pool taking: 54.38.114.34 Dec 26 16:54:03 volumiofranceule ntpd[968]: DNS: Pool taking: 109.190.177.203 Dec 26 16:54:03 volumiofranceule ntpd[968]: DNS: Pool taking: 176.137.36.37 Dec 26 16:54:03 volumiofranceule ntpd[968]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Dec 26 16:54:04 volumiofranceule ntpd[968]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 26 16:54:04 volumiofranceule ntpd[968]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Dec 26 16:54:04 volumiofranceule ntpd[968]: DNS: Pool taking: 82.64.45.50 Dec 26 16:54:04 volumiofranceule ntpd[968]: DNS: Pool taking: 141.95.171.142 Dec 26 16:54:04 volumiofranceule ntpd[968]: DNS: Pool taking: 162.159.200.123 Dec 26 16:54:04 volumiofranceule ntpd[968]: DNS: Pool taking: 82.64.84.116 Dec 26 16:54:04 volumiofranceule ntpd[968]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Dec 26 16:54:04 volumiofranceule volumio[1307]: info: ------------------------------------------- Dec 26 16:54:04 volumiofranceule volumio[1307]: info: ----- Volumio3 ---- Dec 26 16:54:04 volumiofranceule volumio[1307]: info: ------------------------------------------- Dec 26 16:54:04 volumiofranceule volumio[1307]: info: ----- System startup ---- Dec 26 16:54:04 volumiofranceule volumio[1307]: info: ------------------------------------------- Dec 26 16:54:05 volumiofranceule volumio[1307]: info: MYVOLUMIO Environment detected Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Plugin folders cleanup Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Scanning into folder /volumio/app/plugins/ Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Scanning category audio_interface Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Scanning category miscellanea Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Scanning category music_service Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Scanning category plugins.json Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Scanning category system_controller Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Scanning category user_interface Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Scanning into folder /data/plugins/ Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Scanning category music_service Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Scanning category system_hardware Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Plugin folders cleanup completed Dec 26 16:54:05 volumiofranceule volumio[1307]: info: ------------------------------------------- Dec 26 16:54:05 volumiofranceule volumio[1307]: info: ----- Core plugins startup ---- Dec 26 16:54:05 volumiofranceule volumio[1307]: info: ------------------------------------------- Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Loading plugins from folder /volumio/app/plugins/ Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Adding plugin upnp to MyMusic Plugins Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Loading plugins from folder /data/plugins/ Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Loading plugin "system"... Dec 26 16:54:05 volumiofranceule volumio[1307]: info: Loading plugin "appearance"... Dec 26 16:54:07 volumiofranceule volumio[1307]: info: Loading plugin "network"... Dec 26 16:54:07 volumiofranceule volumio[1307]: info: Refreshing Cached IP Addresses Dec 26 16:54:07 volumiofranceule volumio[1307]: info: Loading plugin "services"... Dec 26 16:54:07 volumiofranceule volumio[1307]: info: Loading plugin "alsa_controller"... Dec 26 16:54:07 volumiofranceule sudo[1389]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 16:54:07 volumiofranceule sudo[1390]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 16:54:07 volumiofranceule sudo[1390]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:54:07 volumiofranceule sudo[1389]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:54:07 volumiofranceule sudo[1393]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 26 16:54:07 volumiofranceule sudo[1393]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:54:07 volumiofranceule sudo[1390]: pam_unix(sudo:session): session closed for user root Dec 26 16:54:07 volumiofranceule sudo[1389]: pam_unix(sudo:session): session closed for user root Dec 26 16:54:07 volumiofranceule volumio[1307]: warn: Unable to locate the audio output device HiFiBerry DAC2 Pro. Please configure a valid output device. Dec 26 16:54:07 volumiofranceule volumio[1307]: Invalid card number '2'. Dec 26 16:54:07 volumiofranceule volumio[1307]: info: Hardware Mixer selected but no Hardware mixer available, detecting default mixer Dec 26 16:54:07 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 26 16:54:07 volumiofranceule volumio[1307]: Invalid card number '2'. Dec 26 16:55:04 volumiofranceule ntpd[968]: CLOCK: time stepped by 57.465674 Dec 26 16:55:04 volumiofranceule ntpd[968]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Dec 26 16:55:04 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 26 16:55:04 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 16:55:04 volumiofranceule volumio[1307]: info: Loading plugin "wizard"... Dec 26 16:55:04 volumiofranceule volumio[1307]: info: Loading plugin "networkfs"... Dec 26 16:55:05 volumiofranceule volumio[1307]: info: Starting Udev Watcher for removable devices Dec 26 16:55:05 volumiofranceule volumio[1307]: info: Ignoring mount for partition: boot Dec 26 16:55:05 volumiofranceule volumio[1307]: info: Ignoring mount for partition: volumio Dec 26 16:55:05 volumiofranceule volumio[1307]: info: Ignoring mount for partition: volumio_data Dec 26 16:55:05 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 16:55:05 volumiofranceule volumio[1307]: info: Loading plugin "volumio_command_line_client"... Dec 26 16:55:05 volumiofranceule volumio[1307]: info: Loading plugin "upnp"... Dec 26 16:55:05 volumiofranceule volumio[1307]: info: [1766764505136] Starting Upmpd Daemon Dec 26 16:55:05 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 16:55:05 volumiofranceule volumio[1307]: info: Loading plugin "my_music"... Dec 26 16:55:05 volumiofranceule volumio[1307]: info: Loading plugin "mpd"... Dec 26 16:55:05 volumiofranceule volumio[1307]: info: Loading plugin "upnp_browser"... Dec 26 16:55:05 volumiofranceule volumio-remote-updater[753]: [2025-12-26 16:55:05] [connect] Successful connection Dec 26 16:55:06 volumiofranceule volumio[1307]: info: Loading plugin "alarm-clock"... Dec 26 16:55:06 volumiofranceule volumio[1307]: info: Loading plugin "airplay_emulation"... Dec 26 16:55:06 volumiofranceule volumio[1307]: info: Starting Shairport Sync Dec 26 16:55:06 volumiofranceule volumio[1307]: info: Loading plugin "last_100"... Dec 26 16:55:06 volumiofranceule volumio[1307]: info: Loading plugin "webradio"... Dec 26 16:55:06 volumiofranceule volumio[1307]: info: Loading plugin "i2s_dacs"... Dec 26 16:55:06 volumiofranceule volumio[1307]: info: Loading plugin "volumiodiscovery"... Dec 26 16:55:06 volumiofranceule volumio[1307]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 26 16:55:06 volumiofranceule volumio[1307]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 16:55:06 volumiofranceule volumio[1307]: *** WARNING *** For more information see Dec 26 16:55:06 volumiofranceule volumio[1307]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 26 16:55:06 volumiofranceule volumio[1307]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 16:55:06 volumiofranceule volumio[1307]: *** WARNING *** For more information see Dec 26 16:55:06 volumiofranceule node[1307]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 26 16:55:06 volumiofranceule node[1307]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 16:55:06 volumiofranceule node[1307]: *** WARNING *** For more information see Dec 26 16:55:06 volumiofranceule node[1307]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 26 16:55:06 volumiofranceule node[1307]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 26 16:55:06 volumiofranceule node[1307]: *** WARNING *** For more information see Dec 26 16:55:06 volumiofranceule volumio[1307]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 26 16:55:06 volumiofranceule volumio[1307]: info: Discovery: Started advertising with name: VolumioFranceule Dec 26 16:55:06 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 16:55:06 volumiofranceule volumio[1307]: info: Loading plugin "jellyfin"... Dec 26 16:55:08 volumiofranceule volumio[1307]: info: Loading plugin "outputs"... Dec 26 16:55:08 volumiofranceule volumio[1307]: info: Loading plugin "albumart"... Dec 26 16:55:08 volumiofranceule volumio[1307]: info: Plugin example_plugin is not enabled Dec 26 16:55:08 volumiofranceule volumio[1307]: info: Loading plugin "inputs"... Dec 26 16:55:08 volumiofranceule volumio[1307]: info: Loading plugin "updater_comm"... Dec 26 16:55:08 volumiofranceule volumio[1307]: info: Plugin mpdemulation is not enabled Dec 26 16:55:08 volumiofranceule volumio[1307]: info: Loading plugin "rest_api"... Dec 26 16:55:08 volumiofranceule volumio[1307]: info: Loading plugin "websocket"... Dec 26 16:55:08 volumiofranceule volumio[1307]: info: Starting Socket.io Server version 1.7.4 Dec 26 16:55:08 volumiofranceule volumio[1307]: info: Loading plugin "mpd_oled"... Dec 26 16:55:09 volumiofranceule volumio[1433]: Forking 3 albumart workers Dec 26 16:55:09 volumiofranceule volumio[1307]: info: Applying required configuration parameters for plugin mpd_oled Dec 26 16:55:09 volumiofranceule volumio[1307]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Dec 26 16:55:09 volumiofranceule volumio[1307]: info: Loading i18n strings for locale fr Dec 26 16:55:09 volumiofranceule volumio[1307]: Updating browse sources language Dec 26 16:55:09 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 16:55:10 volumiofranceule sudo[1393]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:10 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::initPlayerControls Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 16:55:11 volumiofranceule volumio[1307]: Express server listening on port 3000 Dec 26 16:55:11 volumiofranceule volumio[1307]: [Metrics] WebUI: 10s 14.11ms Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreStateMachine::resetVolumioState Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreStateMachine::getcurrentVolume Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 16:55:11 volumiofranceule systemd[1]: systemd-fsckd.service: Deactivated successfully. Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreStateMachine::getcurrentVolume Dec 26 16:55:11 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 16:55:11 volumiofranceule volumio[1307]: info: Volumio Network Manager: Network status updated: 2 Dec 26 16:55:11 volumiofranceule volumio[1307]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '2'. Dec 26 16:55:11 volumiofranceule volumio[1307]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '2'. Dec 26 16:55:12 volumiofranceule volumio[1307]: verbose: New Socket.io Connection to 192.168.1.32:3000 from 192.168.1.107 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Dec 26 16:55:12 volumiofranceule volumio[1307]: info: VolumeController:: Volume=undefined Mute =false Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CoreStateMachine::pushState Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioPushState Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CoreStateMachine::updateTrackBlock Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrackBlock Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 16:55:12 volumiofranceule volumio[1307]: info: VolumeController:: Volume=undefined Mute =false Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CoreStateMachine::pushState Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioPushState Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CoreStateMachine::updateTrackBlock Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrackBlock Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 16:55:12 volumiofranceule volumio[1307]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '2'. Dec 26 16:55:12 volumiofranceule dhcpcd[763]: timed out Dec 26 16:55:12 volumiofranceule sh[746]: timed out Dec 26 16:55:12 volumiofranceule sh[648]: ifup: failed to bring up eth0 Dec 26 16:55:12 volumiofranceule systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Dec 26 16:55:12 volumiofranceule systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Dec 26 16:55:12 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:12 volumiofranceule volumio[1307]: info: Reloading queue from file Dec 26 16:55:13 volumiofranceule volumio[1307]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '2'. Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreStateMachine::setRepeat null single undefined Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreStateMachine::pushState Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioPushState Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreStateMachine::setRandom null Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreStateMachine::pushState Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioPushState Dec 26 16:55:13 volumiofranceule volumio[1307]: info: Setting Device type: Raspberry PI Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 16:55:13 volumiofranceule volumio[1307]: info: Discovery: Getting this device information Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 16:55:13 volumiofranceule volumio[1307]: verbose: New Socket.io Connection to 192.168.1.32:3000 from 192.168.1.107 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Dec 26 16:55:13 volumiofranceule volumio[1307]: info: VolumeController:: Volume=undefined Mute =false Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreStateMachine::pushState Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioPushState Dec 26 16:55:13 volumiofranceule volumio[1307]: info: Completed loading Core Plugins Dec 26 16:55:13 volumiofranceule volumio[1307]: info: Preparing to generate the ALSA configuration file Dec 26 16:55:13 volumiofranceule volumio[1307]: info: VolumeController:: Volume=undefined Mute =false Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreStateMachine::pushState Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioPushState Dec 26 16:55:13 volumiofranceule volumio[1307]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 26 16:55:13 volumiofranceule volumio[1307]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Dec 26 16:55:13 volumiofranceule volumio[1307]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 26 16:55:13 volumiofranceule volumio[1307]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Dec 26 16:55:13 volumiofranceule volumio[1307]: info: Reading ALSA contributions from plugins. Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 16:55:13 volumiofranceule volumio[1307]: info: Discovery: Getting this device information Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 16:55:13 volumiofranceule volumio[1307]: info: Discovery: adding da74be2f-a9d1-4b12-bcf9-e499e60d1545 Dec 26 16:55:13 volumiofranceule volumio[1307]: info: Discovery: Found device VolumioFranceule Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:13 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:13 volumiofranceule volumio[1307]: info: Discovery: this is already registered, da74be2f-a9d1-4b12-bcf9-e499e60d1545 Dec 26 16:55:14 volumiofranceule volumio[1307]: info: Discovery: Found device VolumioFranceule Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 16:55:14 volumiofranceule volumio[1307]: info: Discovery: Getting this device information Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 16:55:14 volumiofranceule volumio[1307]: verbose: New Socket.io Connection to 192.168.1.32:3000 from 192.168.1.107 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Dec 26 16:55:14 volumiofranceule volumio[1307]: verbose: New Socket.io Connection to 192.168.1.32:3000 from 192.168.1.107 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3 Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 16:55:14 volumiofranceule volumio[1307]: info: Discovery: Getting this device information Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 16:55:14 volumiofranceule volumio[1307]: info: Asound.conf file unchanged, so no further update is needed Dec 26 16:55:14 volumiofranceule volumio[1307]: info: Output device has changed, restarting MPD Dec 26 16:55:14 volumiofranceule sudo[1495]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 16:55:14 volumiofranceule sudo[1495]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:14 volumiofranceule volumio[1307]: info: Output device has changed, restarting Shairport Sync Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:14 volumiofranceule sudo[1495]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:14 volumiofranceule volumio[1443]: Starting albumart workers Dec 26 16:55:14 volumiofranceule sudo[1497]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 16:55:14 volumiofranceule sudo[1497]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:14 volumiofranceule volumio[1307]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 16:55:14 volumiofranceule volumio[1307]: info: ___________ START PLUGINS ___________ Dec 26 16:55:14 volumiofranceule volumio[1307]: info: ControllerMpd::onStart: Initializing MPD Dec 26 16:55:14 volumiofranceule volumio[1307]: info: Creating MPD Configuration file Dec 26 16:55:14 volumiofranceule volumio[1444]: Starting albumart workers Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 16:55:14 volumiofranceule volumio[1307]: info: [1766764514886] CoreMusicLibrary::Adding element Serveurs Média Dec 26 16:55:14 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 16:55:14 volumiofranceule systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 26 16:55:14 volumiofranceule systemd[1]: Starting mpd.service - Music Player Daemon... Dec 26 16:55:14 volumiofranceule sudo[1508]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 16:55:14 volumiofranceule sudo[1508]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:14 volumiofranceule sudo[1511]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 16:55:14 volumiofranceule sudo[1511]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:15 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:15 volumiofranceule sudo[1508]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:15 volumiofranceule sudo[1514]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 26 16:55:15 volumiofranceule sudo[1514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:55:15 volumiofranceule sudo[1523]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 26 16:55:15 volumiofranceule sudo[1514]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:15 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:15 volumiofranceule systemd[1]: mpd.service: Deactivated successfully. Dec 26 16:55:15 volumiofranceule systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 26 16:55:15 volumiofranceule systemd[1]: mpd.socket: Deactivated successfully. Dec 26 16:55:15 volumiofranceule systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 26 16:55:15 volumiofranceule systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 26 16:55:15 volumiofranceule systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 26 16:55:15 volumiofranceule systemd[1]: Starting mpd.service - Music Player Daemon... Dec 26 16:55:15 volumiofranceule sudo[1533]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 26 16:55:15 volumiofranceule sudo[1533]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:55:15 volumiofranceule sudo[1534]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 26 16:55:15 volumiofranceule sudo[1533]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:15 volumiofranceule volumio[1307]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 16:55:15 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:15 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:15 volumiofranceule volumio[1307]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 16:55:15 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 16:55:15 volumiofranceule volumio[1307]: info: [1766764515460] CoreMusicLibrary::Adding element Last_100 Dec 26 16:55:15 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 16:55:15 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 16:55:15 volumiofranceule volumio[1307]: info: [1766764515462] CoreMusicLibrary::Adding element Webradio Dec 26 16:55:15 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 16:55:15 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 16:55:15 volumiofranceule volumio[1445]: Starting albumart workers Dec 26 16:55:15 volumiofranceule volumio[1307]: info: Initializing BBC Radios Dec 26 16:55:15 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 16:55:15 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:16 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 16:55:16 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 16:55:16 volumiofranceule volumio[1307]: info: Discovery: Getting this device information Dec 26 16:55:16 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:16 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:16 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 16:55:16 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 16:55:16 volumiofranceule volumio[1307]: info: [1766764516203] CoreMusicLibrary::Adding element Jellyfin Dec 26 16:55:16 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 16:55:16 volumiofranceule volumio[1307]: Cannot find translation for source Jellyfin Dec 26 16:55:16 volumiofranceule volumio[1307]: info: [jellyfin] Initialized plugin with device info: {"host":"http://192.168.1.32","id":"da74be2f-a9d1-4b12-bcf9-e499e60d1545","name":"VolumioFranceule","serviceName":"Volumio","state":{"albumart":"http://etiden.hd.free.fr:3535/Items/d26eca73eabba85f34b3135a8be9a870/Images/Primary?maxWidth=500&maxHeight=500&quality=90","artist":"Bruce Springsteen","mute":false,"status":"stop","track":"Nebraska","volume":""},"type":"device"} Dec 26 16:55:16 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 26 16:55:16 volumiofranceule volumio[1307]: info: Volumio Calling Home Dec 26 16:55:16 volumiofranceule sudo[1557]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /tmp/mpd_oled_plugin.sh Dec 26 16:55:16 volumiofranceule sudo[1557]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:16 volumiofranceule sudo[1559]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start mpd_oled_plugin.service Dec 26 16:55:16 volumiofranceule sudo[1559]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:16 volumiofranceule sudo[1557]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:17 volumiofranceule volumio[1307]: info: Preparing to generate the ALSA configuration file Dec 26 16:55:19 volumiofranceule mpd[1536]: 2025-12-26T16:55:19 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 26 16:55:19 volumiofranceule systemd[1]: Started mpd.service - Music Player Daemon. Dec 26 16:55:19 volumiofranceule sudo[1511]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:19 volumiofranceule sudo[1497]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:19 volumiofranceule (lugin.sh)[1585]: mpd_oled_plugin.service: Failed to execute /tmp/mpd_oled_plugin.sh: Text file busy Dec 26 16:55:19 volumiofranceule (lugin.sh)[1585]: mpd_oled_plugin.service: Failed at step EXEC spawning /tmp/mpd_oled_plugin.sh: Text file busy Dec 26 16:55:19 volumiofranceule systemd[1]: Started mpd_oled_plugin.service - MPD OLED Plugin. Dec 26 16:55:19 volumiofranceule systemd[1]: mpd_oled_plugin.service: Main process exited, code=exited, status=203/EXEC Dec 26 16:55:19 volumiofranceule systemd[1]: mpd_oled_plugin.service: Failed with result 'exit-code'. Dec 26 16:55:19 volumiofranceule sudo[1559]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:19 volumiofranceule sudo[1587]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 16:55:19 volumiofranceule sudo[1587]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:19 volumiofranceule sudo[1587]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:19 volumiofranceule sudo[1589]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 16:55:19 volumiofranceule volumio[1307]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Dec 26 16:55:19 volumiofranceule volumio[1307]: info: Reading ALSA contributions from plugins. Dec 26 16:55:19 volumiofranceule sudo[1589]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:19 volumiofranceule volumio[1307]: info: [MPD_OLED Plugin] Started mpd_oled_plugin service Dec 26 16:55:19 volumiofranceule volumio[1307]: info: [MPD_OLED Plugin] Set execute permissions on /tmp/mpd_oled_plugin.sh Dec 26 16:55:19 volumiofranceule sudo[1589]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:19 volumiofranceule volumio[1307]: info: Completed starting Core Plugins Dec 26 16:55:19 volumiofranceule volumio[1307]: info: ------------------------------------------- Dec 26 16:55:19 volumiofranceule volumio[1307]: info: ----- MyVolumio plugins startup ---- Dec 26 16:55:19 volumiofranceule volumio[1307]: info: ------------------------------------------- Dec 26 16:55:19 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 26 16:55:19 volumiofranceule volumio[1307]: info: MPD Permissions set Dec 26 16:55:19 volumiofranceule volumio[1307]: info: MPD Permissions set Dec 26 16:55:20 volumiofranceule volumio[1307]: verbose: New Socket.io Connection to 192.168.1.32:3000 from 192.168.1.107 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Dec 26 16:55:20 volumiofranceule volumio[1307]: info: Volumio called home Dec 26 16:55:20 volumiofranceule volumio[1307]: info: [MPD_OLED Plugin] tmp script created /tmp/mpd_oled_plugin.sh Dec 26 16:55:20 volumiofranceule volumio[1307]: error: MPD error: The expression evaluated to a falsy value: Dec 26 16:55:20 volumiofranceule volumio[1307]: assert.ok(self.idling) Dec 26 16:55:20 volumiofranceule volumio[1307]: error: The expression evaluated to a falsy value: Dec 26 16:55:20 volumiofranceule volumio[1307]: assert.ok(self.idling) Dec 26 16:55:20 volumiofranceule volumio[1307]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 26 16:55:20 volumiofranceule volumio[1307]: info: MPD running with PID1536 Dec 26 16:55:20 volumiofranceule volumio[1307]: ,establishing connection Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:20 volumiofranceule volumio[1307]: error: updateQueue error: null Dec 26 16:55:20 volumiofranceule volumio-remote-updater[753]: [2025-12-26 16:55:20] [connect] Successful connection Dec 26 16:55:21 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 16:55:21 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 16:55:21 volumiofranceule volumio[1307]: info: Discovery: Getting this device information Dec 26 16:55:21 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:21 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:21 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 16:55:21 volumiofranceule volumio[1307]: error: updateQueue error: null Dec 26 16:55:21 volumiofranceule volumio-remote-updater[753]: [2025-12-26 16:55:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1766764520 101 Dec 26 16:55:21 volumiofranceule volumio[1307]: 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: 4 Dec 26 16:55:21 volumiofranceule volumio[1307]: info: Starting Shairport Sync Dec 26 16:55:21 volumiofranceule volumio[1307]: info: Starting Shairport Sync Dec 26 16:55:21 volumiofranceule volumio[1307]: info: Starting Shairport Sync Dec 26 16:55:21 volumiofranceule sudo[1608]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 26 16:55:21 volumiofranceule sudo[1610]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 16:55:21 volumiofranceule sudo[1608]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:21 volumiofranceule volumio[1307]: verbose: New Socket.io Connection to 192.168.1.32:3000 from 192.168.1.107 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Dec 26 16:55:21 volumiofranceule sudo[1613]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 16:55:21 volumiofranceule sudo[1613]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:21 volumiofranceule sudo[1610]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:21 volumiofranceule volumio[1307]: info: [jellyfin-poller] Polled http://etiden.hd.free.fr:3535: online Dec 26 16:55:21 volumiofranceule volumio[1307]: info: Asound.conf file unchanged, so no further update is needed Dec 26 16:55:21 volumiofranceule volumio[1307]: info: Output device has changed, restarting MPD Dec 26 16:55:21 volumiofranceule sudo[1614]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 16:55:21 volumiofranceule sudo[1614]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:21 volumiofranceule volumio[1307]: info: Output device has changed, restarting Shairport Sync Dec 26 16:55:21 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:21 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:21 volumiofranceule sudo[1620]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 16:55:21 volumiofranceule systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 26 16:55:21 volumiofranceule systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 26 16:55:21 volumiofranceule systemd[1]: shairport-sync.service: Deactivated successfully. Dec 26 16:55:21 volumiofranceule systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:55:21 volumiofranceule systemd[1]: shairport-sync.service: Consumed 1.263s CPU time. Dec 26 16:55:21 volumiofranceule systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:55:21 volumiofranceule systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 26 16:55:21 volumiofranceule systemd[1]: shairport-sync.service: Deactivated successfully. Dec 26 16:55:21 volumiofranceule sudo[1610]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:21 volumiofranceule systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:55:21 volumiofranceule systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:55:21 volumiofranceule sudo[1608]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:21 volumiofranceule sudo[1623]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 16:55:21 volumiofranceule sudo[1623]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:21 volumiofranceule sudo[1613]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:21 volumiofranceule systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 26 16:55:21 volumiofranceule systemd[1]: shairport-sync.service: Deactivated successfully. Dec 26 16:55:21 volumiofranceule systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:55:21 volumiofranceule systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:55:21 volumiofranceule sudo[1620]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:21 volumiofranceule sudo[1614]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:21 volumiofranceule sudo[1620]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:22 volumiofranceule volumio[1307]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 16:55:22 volumiofranceule systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 26 16:55:22 volumiofranceule volumio[1307]: info: MPD Permissions set Dec 26 16:55:22 volumiofranceule volumio[1307]: info: Shairport-Sync Started Dec 26 16:55:22 volumiofranceule systemd[1]: mpd.service: Deactivated successfully. Dec 26 16:55:22 volumiofranceule systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 26 16:55:22 volumiofranceule systemd[1]: mpd.service: Consumed 3.110s CPU time. Dec 26 16:55:22 volumiofranceule systemd[1]: mpd.socket: Deactivated successfully. Dec 26 16:55:22 volumiofranceule systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 26 16:55:22 volumiofranceule systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 26 16:55:22 volumiofranceule systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 26 16:55:22 volumiofranceule systemd[1]: Starting mpd.service - Music Player Daemon... Dec 26 16:55:22 volumiofranceule volumio[1307]: Error adding Membership: Error: addMembership EINVAL Dec 26 16:55:22 volumiofranceule volumio[1307]: info: Shairport-Sync Started Dec 26 16:55:22 volumiofranceule volumio[1307]: info: Shairport-Sync Started Dec 26 16:55:22 volumiofranceule volumio[1307]: info: Upmpdcli Daemon Started Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 16:55:22 volumiofranceule volumio[1307]: info: Discovery: Getting this device information Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 16:55:22 volumiofranceule volumio[1307]: error: Upnp client error: Error: connect ECONNRESET 127.0.0.1:6600 Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:22 volumiofranceule sudo[1663]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:22 volumiofranceule sudo[1663]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:55:22 volumiofranceule sudo[1663]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:22 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:55:22 volumiofranceule volumio[1307]: info: Starting Shairport Sync Dec 26 16:55:23 volumiofranceule sudo[1672]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 16:55:23 volumiofranceule sudo[1672]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:23 volumiofranceule sudo[1675]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 26 16:55:23 volumiofranceule sudo[1675]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:23 volumiofranceule sudo[1677]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 26 16:55:23 volumiofranceule sudo[1677]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:23 volumiofranceule systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 26 16:55:23 volumiofranceule systemd[1]: shairport-sync.service: Deactivated successfully. Dec 26 16:55:23 volumiofranceule systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:55:23 volumiofranceule systemd[1]: shairport-sync.service: Consumed 1.100s CPU time. Dec 26 16:55:23 volumiofranceule systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:55:23 volumiofranceule sudo[1672]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:23 volumiofranceule volumio[1307]: info: Shairport-Sync Started Dec 26 16:55:24 volumiofranceule mpd[1665]: 2025-12-26T16:55:24 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 26 16:55:24 volumiofranceule systemd[1]: Started mpd.service - Music Player Daemon. Dec 26 16:55:24 volumiofranceule sudo[1623]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:24 volumiofranceule systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 26 16:55:24 volumiofranceule mpd_monitor.sh[1697]: MPD Monitor Service: Starting MPD Monitor Service Dec 26 16:55:24 volumiofranceule sudo[1677]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:24 volumiofranceule sudo[1675]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:24 volumiofranceule volumio[1307]: info: Successfully started MPD Monitor Dec 26 16:55:24 volumiofranceule volumio[1307]: info: Successfully started MPD Monitor Dec 26 16:55:24 volumiofranceule volumio[1307]: error: updateQueue error: null Dec 26 16:55:24 volumiofranceule sudo[1702]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 16:55:24 volumiofranceule sudo[1702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:24 volumiofranceule sudo[1704]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 16:55:24 volumiofranceule sudo[1704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:24 volumiofranceule sudo[1702]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:24 volumiofranceule sudo[1704]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:24 volumiofranceule volumio[1307]: verbose: New Socket.io Connection to 192.168.1.32 from 192.168.1.107 UA: Mozilla/5.0 (Linux; Android 15; SM-X210 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 26 16:55:24 volumiofranceule sudo[1708]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 16:55:24 volumiofranceule sudo[1708]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:24 volumiofranceule sudo[1710]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 16:55:24 volumiofranceule sudo[1710]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:24 volumiofranceule sudo[1710]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:24 volumiofranceule sudo[1708]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:25 volumiofranceule volumio[1307]: verbose: New Socket.io Connection to 192.168.1.32 from 192.168.1.107 UA: Mozilla/5.0 (Linux; Android 15; SM-X210 Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Dec 26 16:55:25 volumiofranceule volumio[1307]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetVisibleSources Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 26 16:55:25 volumiofranceule volumio[1307]: info: Received Get System Info Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 16:55:25 volumiofranceule volumio[1307]: info: Discovery: Getting this device information Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:25 volumiofranceule volumio[1307]: info: Listing playlists Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 26 16:55:25 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 26 16:55:26 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:26 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:26 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 16:55:26 volumiofranceule volumio[1307]: info: Received Get System Info Dec 26 16:55:26 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 16:55:26 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 16:55:26 volumiofranceule volumio[1307]: info: Discovery: Getting this device information Dec 26 16:55:26 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:26 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:26 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 16:55:27 volumiofranceule sudo[1734]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 26 16:55:27 volumiofranceule sudo[1734]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:27 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 26 16:55:27 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 26 16:55:27 volumiofranceule systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 26 16:55:27 volumiofranceule systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 26 16:55:27 volumiofranceule systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 26 16:55:27 volumiofranceule systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 26 16:55:27 volumiofranceule systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 26 16:55:27 volumiofranceule mpd_monitor.sh[1740]: MPD Monitor Service: Starting MPD Monitor Service Dec 26 16:55:27 volumiofranceule sudo[1734]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:27 volumiofranceule volumio[1307]: info: Successfully started MPD Monitor Dec 26 16:55:27 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 16:55:27 volumiofranceule volumio[1307]: info: Received Get System Info Dec 26 16:55:27 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 16:55:27 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 16:55:27 volumiofranceule volumio[1307]: info: Discovery: Getting this device information Dec 26 16:55:27 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:27 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:27 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 16:55:27 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 26 16:55:28 volumiofranceule volumio[1307]: info: Adding plugin bluetooth to MyMusic Plugins Dec 26 16:55:28 volumiofranceule volumio[1307]: info: Adding plugin multiroom to MyMusic Plugins Dec 26 16:55:28 volumiofranceule volumio[1307]: info: Adding plugin metavolumio to MyMusic Plugins Dec 26 16:55:28 volumiofranceule volumio[1307]: info: Adding plugin cd_controller to MyMusic Plugins Dec 26 16:55:28 volumiofranceule systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 26 16:55:28 volumiofranceule systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 26 16:55:28 volumiofranceule volumio[1307]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 26 16:55:28 volumiofranceule volumio[1307]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 26 16:55:28 volumiofranceule volumio[1307]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 26 16:55:28 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 26 16:55:33 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 26 16:55:33 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 26 16:55:33 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:33 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:34 volumiofranceule volumio[1307]: info: Starting MyVolumio Remote Streaming Endpoints Dec 26 16:55:34 volumiofranceule volumio[1307]: info: MyVolumio login type: Token Dec 26 16:55:34 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 26 16:55:34 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 26 16:55:38 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 26 16:55:38 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 26 16:55:38 volumiofranceule volumio[1307]: info: Streaming services startup Dec 26 16:55:38 volumiofranceule volumio[1307]: info: Starting Streaming Daemon Dec 26 16:55:38 volumiofranceule sudo[1782]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 26 16:55:38 volumiofranceule sudo[1782]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:38 volumiofranceule volumio[1307]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Dec 26 16:55:38 volumiofranceule sudo[1782]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:38 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 26 16:55:38 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioPlay Dec 26 16:55:38 volumiofranceule volumio[1307]: info: CoreStateMachine::play index undefined Dec 26 16:55:38 volumiofranceule volumio[1307]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 16:55:38 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:38 volumiofranceule volumio[1307]: info: CoreStateMachine::startPlaybackTimer Dec 26 16:55:38 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:38 volumiofranceule volumio[1307]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/Marcel@5db5f92083a14e42b50d0bb77f64badc/song@songId=d26eca73eabba85f34b3135a8be9a870 Dec 26 16:55:38 volumiofranceule volumio[1307]: info: [jellyfin-conn] Using previously assigned device Id for Marcel@thinkcentre-jellyfin: 929c5d91-d38f-4413-927e-07d6745439b5 Dec 26 16:55:38 volumiofranceule volumio[1307]: error: Cannot start Volumio Streaming Daemon Dec 26 16:55:38 volumiofranceule volumio[1307]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 26 16:55:38 volumiofranceule volumio[1307]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 26 16:55:38 volumiofranceule volumio[1307]: info: [jellyfin-conn] Login successful: Marcel@thinkcentre-jellyfin Dec 26 16:55:39 volumiofranceule volumio[1307]: info: [jellyfin-play] Stream URL for Nebraska: http://etiden.hd.free.fr:3535/Audio/d26eca73eabba85f34b3135a8be9a870/stream.flac?static=true&mediaSourceId=d26eca73eabba85f34b3135a8be9a870&tag=7871b3604e3466f28979263bf0ca3fb0 Dec 26 16:55:39 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand stop Dec 26 16:55:39 volumiofranceule volumio[1307]: info: sendMpdCommand stop took 56 milliseconds Dec 26 16:55:39 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand clear Dec 26 16:55:39 volumiofranceule volumio[1307]: info: Dec 26 16:55:39 volumiofranceule volumio[1307]: ---------------------------- MPD announces system playlist update Dec 26 16:55:39 volumiofranceule volumio[1307]: info: Ignoring MPD Status Update Dec 26 16:55:39 volumiofranceule volumio[1307]: info: sendMpdCommand clear took 61 milliseconds Dec 26 16:55:39 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand load "http://etiden.hd.free.fr:3535/Audio/d26eca73eabba85f34b3135a8be9a870/stream.flac?static=true&mediaSourceId=d26eca73eabba85f34b3135a8be9a870&tag=7871b3604e3466f28979263bf0ca3fb0&t.flac" Dec 26 16:55:39 volumiofranceule volumio[1307]: error: updateQueue error: null Dec 26 16:55:39 volumiofranceule volumio[1307]: info: ------------------------------ 46ms Dec 26 16:55:39 volumiofranceule volumio[1307]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 26 16:55:39 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand addid "http://etiden.hd.free.fr:3535/Audio/d26eca73eabba85f34b3135a8be9a870/stream.flac?static=true&mediaSourceId=d26eca73eabba85f34b3135a8be9a870&tag=7871b3604e3466f28979263bf0ca3fb0&t.flac" Dec 26 16:55:39 volumiofranceule volumio[1307]: info: Dec 26 16:55:39 volumiofranceule volumio[1307]: ---------------------------- MPD announces system playlist update Dec 26 16:55:39 volumiofranceule volumio[1307]: info: Ignoring MPD Status Update Dec 26 16:55:39 volumiofranceule volumio[1307]: info: sendMpdCommand addid "http://etiden.hd.free.fr:3535/Audio/d26eca73eabba85f34b3135a8be9a870/stream.flac?static=true&mediaSourceId=d26eca73eabba85f34b3135a8be9a870&tag=7871b3604e3466f28979263bf0ca3fb0&t.flac" took 30 milliseconds Dec 26 16:55:39 volumiofranceule volumio[1307]: verbose: MPD COMMAND [object Object] Dec 26 16:55:39 volumiofranceule volumio[1307]: verbose: MPD COMMAND [object Object] Dec 26 16:55:39 volumiofranceule volumio[1307]: verbose: MPD COMMAND [object Object] Dec 26 16:55:39 volumiofranceule volumio[1307]: info: Dec 26 16:55:39 volumiofranceule volumio[1307]: ---------------------------- MPD announces system playlist update Dec 26 16:55:39 volumiofranceule volumio[1307]: info: Ignoring MPD Status Update Dec 26 16:55:39 volumiofranceule volumio[1307]: info: ------------------------------ 48ms Dec 26 16:55:39 volumiofranceule volumio[1307]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 26 16:55:39 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand play Dec 26 16:55:39 volumiofranceule volumio[1307]: info: ------------------------------ 40ms Dec 26 16:55:39 volumiofranceule volumio[1307]: info: sendMpdCommand play took 39 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: info: ControllerMpd::getState Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand status Dec 26 16:55:40 volumiofranceule volumio[1307]: info: Dec 26 16:55:40 volumiofranceule volumio[1307]: ---------------------------- MPD announces state update: player Dec 26 16:55:40 volumiofranceule volumio[1307]: info: ControllerMpd::getState Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand status Dec 26 16:55:40 volumiofranceule volumio[1307]: info: ControllerMpd::getState Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand status Dec 26 16:55:40 volumiofranceule volumio[1307]: info: Dec 26 16:55:40 volumiofranceule volumio[1307]: ---------------------------- MPD announces state update: player Dec 26 16:55:40 volumiofranceule volumio[1307]: info: ControllerMpd::getState Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand status Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 26 16:55:40 volumiofranceule volumio[1307]: info: sendMpdCommand status took 75 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 26 16:55:40 volumiofranceule volumio[1307]: info: sendMpdCommand status took 75 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::parseState Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::parseState Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 26 16:55:40 volumiofranceule volumio[1307]: info: sendMpdCommand status took 314 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 26 16:55:40 volumiofranceule volumio[1307]: info: sendMpdCommand status took 324 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: info: sendMpdCommand clearerror took 252 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: info: sendMpdCommand clearerror took 252 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: info: sendMpdCommand playlistinfo took 218 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: info: sendMpdCommand playlistinfo took 218 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::parseState Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::parseState Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::parseTrackInfo Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::parseTrackInfo Dec 26 16:55:40 volumiofranceule volumio[1307]: info: ControllerMpd::pushState Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CoreCommandRouter::servicePushState Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nebraska","artist":"Bruce Springsteen","album":"Nebraska","uri":"http://etiden.hd.free.fr:3535/Audio/d26eca73eabba85f34b3135a8be9a870/stream.flac?static=true&mediaSourceId=d26eca73eabba85f34b3135a8be9a870&tag=7871b3604e3466f28979263bf0ca3fb0&t.flac","trackType":"flac"} Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: CURRENT POSITION 0 Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CoreStateMachine::syncState stateService pause Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CoreStateMachine::syncState currentStatus stop Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CoreStateMachine::pushState Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioPushState Dec 26 16:55:40 volumiofranceule volumio[1307]: info: ------------------------------ 457ms Dec 26 16:55:40 volumiofranceule volumio[1307]: info: Pushing Favourites {"favourite":false} Dec 26 16:55:40 volumiofranceule volumio[1307]: info: sendMpdCommand clearerror took 296 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: info: sendMpdCommand clearerror took 286 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: info: sendMpdCommand playlistinfo took 282 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: info: sendMpdCommand playlistinfo took 281 milliseconds Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::parseTrackInfo Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: ControllerMpd::parseTrackInfo Dec 26 16:55:40 volumiofranceule volumio[1307]: info: ControllerMpd::pushState Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CoreCommandRouter::servicePushState Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nebraska","artist":"Bruce Springsteen","album":"Nebraska","uri":"http://etiden.hd.free.fr:3535/Audio/d26eca73eabba85f34b3135a8be9a870/stream.flac?static=true&mediaSourceId=d26eca73eabba85f34b3135a8be9a870&tag=7871b3604e3466f28979263bf0ca3fb0&t.flac","trackType":"flac"} Dec 26 16:55:40 volumiofranceule volumio[1307]: verbose: CURRENT POSITION 0 Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CoreStateMachine::syncState stateService pause Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CoreStateMachine::syncState currentStatus stop Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CoreStateMachine::pushState Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 16:55:40 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioPushState Dec 26 16:55:40 volumiofranceule volumio[1307]: info: ------------------------------ 713ms Dec 26 16:55:40 volumiofranceule volumio[1307]: info: Pushing Favourites {"favourite":false} Dec 26 16:55:40 volumiofranceule volumio[1307]: info: [jellyfin-play]: Reported 'pause' for song: Nebraska (at 0 ms) Dec 26 16:55:40 volumiofranceule volumio[1307]: info: [jellyfin-play]: Mark song Nebraska as played by Marcel. Dec 26 16:55:40 volumiofranceule volumio[1307]: info: MyVolumio token set successfully Dec 26 16:55:40 volumiofranceule volumio[1307]: info: MYVOLUMIO: Adding device Dec 26 16:55:40 volumiofranceule volumio[1307]: info: MYVOLUMIO: Evaluating Server Dec 26 16:55:42 volumiofranceule volumio[1307]: info: MyVolumio status changed Dec 26 16:55:42 volumiofranceule volumio[1307]: info: Streaming services startup Dec 26 16:55:42 volumiofranceule volumio[1307]: info: Starting Streaming Daemon Dec 26 16:55:42 volumiofranceule volumio[1307]: info: Removing browser output: myVolumio user plan is not superstar Dec 26 16:55:42 volumiofranceule volumio[1307]: info: Removing audio output: Dec 26 16:55:42 volumiofranceule volumio[1307]: info: Stoppping Tunnel 1 Dec 26 16:55:42 volumiofranceule sudo[1819]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 26 16:55:42 volumiofranceule sudo[1821]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Dec 26 16:55:42 volumiofranceule sudo[1819]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:42 volumiofranceule sudo[1821]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:55:42 volumiofranceule sudo[1819]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:42 volumiofranceule upmpdcli[1824]: writing RSA key Dec 26 16:55:42 volumiofranceule volumio[1307]: info: Setting Geolocation for MyVolumio to eu8 Dec 26 16:55:42 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:42 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:42 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:42 volumiofranceule systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 26 16:55:42 volumiofranceule systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 26 16:55:42 volumiofranceule systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 26 16:55:42 volumiofranceule systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 26 16:55:42 volumiofranceule systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 26 16:55:42 volumiofranceule systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 26 16:55:42 volumiofranceule volumio[1307]: error: Cannot start Volumio Streaming Daemon Dec 26 16:55:42 volumiofranceule volumio[1307]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 26 16:55:42 volumiofranceule volumio[1307]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 26 16:55:42 volumiofranceule sudo[1821]: pam_unix(sudo:session): session closed for user root Dec 26 16:55:42 volumiofranceule volumio[1307]: info: Remote SSH Stopped Dec 26 16:55:43 volumiofranceule volumio[1307]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Dec 26 16:55:43 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 26 16:55:43 volumiofranceule volumio[1307]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 26 16:55:43 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 26 16:55:43 volumiofranceule volumio[1307]: info: Received Get System Version Dec 26 16:55:43 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 16:55:43 volumiofranceule volumio[1307]: info: Received Get System Info Dec 26 16:55:43 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 16:55:43 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 16:55:43 volumiofranceule volumio[1307]: info: Discovery: Getting this device information Dec 26 16:55:43 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioGetState Dec 26 16:55:43 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 16:55:43 volumiofranceule volumio[1307]: info: Updating MyVolumio device info Dec 26 16:55:43 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:43 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:43 volumiofranceule volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:55:43 volumiofranceule volumio[1307]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Dec 26 16:55:44 volumiofranceule volumio[1307]: info: CoreCommandRouter::volumioPlay Dec 26 16:55:44 volumiofranceule volumio[1307]: info: CoreStateMachine::play index undefined Dec 26 16:55:44 volumiofranceule volumio[1307]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 26 16:55:44 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:44 volumiofranceule volumio[1307]: info: CoreStateMachine::startPlaybackTimer Dec 26 16:55:44 volumiofranceule volumio[1307]: info: CorePlayQueue::getTrack 0 Dec 26 16:55:44 volumiofranceule volumio[1307]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/Marcel@5db5f92083a14e42b50d0bb77f64badc/song@songId=d26eca73eabba85f34b3135a8be9a870 Dec 26 16:55:45 volumiofranceule volumio[1307]: info: [jellyfin-play] Stream URL for Nebraska: http://etiden.hd.free.fr:3535/Audio/d26eca73eabba85f34b3135a8be9a870/stream.flac?static=true&mediaSourceId=d26eca73eabba85f34b3135a8be9a870&tag=7871b3604e3466f28979263bf0ca3fb0 Dec 26 16:55:45 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand stop Dec 26 16:55:45 volumiofranceule volumio[1307]: info: ControllerMpd::getState Dec 26 16:55:45 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand status Dec 26 16:55:45 volumiofranceule volumio[1307]: info: Dec 26 16:55:45 volumiofranceule volumio[1307]: ---------------------------- MPD announces state update: player Dec 26 16:55:45 volumiofranceule volumio[1307]: info: sendMpdCommand stop took 6 milliseconds Dec 26 16:55:45 volumiofranceule volumio[1307]: info: ControllerMpd::getState Dec 26 16:55:45 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand status Dec 26 16:55:45 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand clear Dec 26 16:55:45 volumiofranceule volumio[1307]: info: Dec 26 16:55:45 volumiofranceule volumio[1307]: ---------------------------- MPD announces system playlist update Dec 26 16:55:45 volumiofranceule volumio[1307]: info: Ignoring MPD Status Update Dec 26 16:55:45 volumiofranceule volumio[1307]: info: sendMpdCommand status took 3 milliseconds Dec 26 16:55:45 volumiofranceule volumio[1307]: info: sendMpdCommand status took 2 milliseconds Dec 26 16:55:45 volumiofranceule volumio[1307]: info: sendMpdCommand clear took 26 milliseconds Dec 26 16:55:45 volumiofranceule volumio[1307]: verbose: ControllerMpd::parseState Dec 26 16:55:45 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 16:55:45 volumiofranceule volumio[1307]: verbose: ControllerMpd::parseState Dec 26 16:55:45 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 26 16:55:45 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand load "http://etiden.hd.free.fr:3535/Audio/d26eca73eabba85f34b3135a8be9a870/stream.flac?static=true&mediaSourceId=d26eca73eabba85f34b3135a8be9a870&tag=7871b3604e3466f28979263bf0ca3fb0&t.flac" Dec 26 16:55:45 volumiofranceule volumio[1307]: error: updateQueue error: null Dec 26 16:55:45 volumiofranceule volumio[1307]: info: ------------------------------ 322ms Dec 26 16:55:45 volumiofranceule volumio[1307]: info: sendMpdCommand playlistinfo took 297 milliseconds Dec 26 16:55:45 volumiofranceule volumio[1307]: info: sendMpdCommand playlistinfo took 297 milliseconds Dec 26 16:55:45 volumiofranceule volumio[1307]: verbose: ControllerMpd::sendMpdCommand addid "http://etiden.hd.free.fr:3535/Audio/d26eca73eabba85f34b3135a8be9a870/stream.flac?static=true&mediaSourceId=d26eca73eabba85f34b3135a8be9a870&tag=7871b3604e3466f28979263bf0ca3fb0&t.flac" Dec 26 16:55:45 volumiofranceule volumio[1307]: verbose: ControllerMpd::parseTrackInfo Dec 26 16:55:45 volumiofranceule volumio[1307]: verbose: ControllerMpd::parseTrackInfo Dec 26 16:55:45 volumiofranceule volumio[1307]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 26 16:55:45 volumiofranceule volumio[1307]: info: ------------------------------ 340ms Dec 26 16:55:45 volumiofranceule volumio[1307]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 16:55:45 volumiofranceule volumio[1307]: TypeError: Cannot read properties of undefined (reading 'split') Dec 26 16:55:45 volumiofranceule volumio[1307]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:280:60) Dec 26 16:55:45 volumiofranceule volumio[1307]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Dec 26 16:55:45 volumiofranceule volumio[1307]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Dec 26 16:55:45 volumiofranceule volumio[1307]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 16:55:48 volumiofranceule sudo[1860]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-26 16:54' Dec 26 16:55:48 volumiofranceule sudo[1860]: 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="ec1ce6b3390e13e82b9cc0453f957c4f5298419e" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Nov 17 16:31:40 UTC 2025" VOLUMIO_VERSION="4.071" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5fbe1bcf6936184712979c0bfaf061f2"