-- Logs begin at Fri 2022-09-30 13:13:47 UTC, end at Sun 2025-06-01 08:29:02 UTC. -- Jun 01 08:28:00 volumio-sala systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Jun 01 08:28:00 volumio-sala systemd[1]: Stopping Xbindrc... Jun 01 08:28:00 volumio-sala systemd[1]: Starting Xbindrc... Jun 01 08:28:00 volumio-sala systemd[1]: Started Xbindrc. Jun 01 08:28:02 volumio-sala systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Jun 01 08:28:02 volumio-sala systemd[1]: Stopping Xbindrc... Jun 01 08:28:02 volumio-sala systemd[1]: Starting Xbindrc... Jun 01 08:28:02 volumio-sala systemd[1]: Started Xbindrc. Jun 01 08:28:02 volumio-sala smbd[901]: Starting SMB/CIFS daemon: smbd[2025/06/01 08:28:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 01 08:28:02 volumio-sala smbd[901]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 01 08:28:02 volumio-sala smbd[901]: [2025/06/01 08:28:02, 0] ../lib/util/util.c:220(directory_create_or_exist) Jun 01 08:28:02 volumio-sala smbd[901]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jun 01 08:28:02 volumio-sala smbd[901]: [2025/06/01 08:28:02, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Jun 01 08:28:02 volumio-sala smbd[901]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jun 01 08:28:02 volumio-sala smbd[901]: [2025/06/01 08:28:02, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Jun 01 08:28:02 volumio-sala smbd[901]: Unable to setup corepath for smbd: No such file or directory Jun 01 08:28:02 volumio-sala smbd[901]: [2025/06/01 08:28:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 01 08:28:02 volumio-sala smbd[901]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 01 08:28:02 volumio-sala smbd[901]: [2025/06/01 08:28:02, 0] ../source3/smbd/server.c:1241(main) Jun 01 08:28:02 volumio-sala smbd[901]: smbd version 4.2.14-Debian started. Jun 01 08:28:02 volumio-sala smbd[901]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jun 01 08:28:03 volumio-sala smbd[959]: [2025/06/01 08:28:03.019367, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 01 08:28:03 volumio-sala smbd[959]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 01 08:28:03 volumio-sala smbd[959]: [2025/06/01 08:28:03.033685, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 01 08:28:03 volumio-sala smbd[959]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 01 08:28:03 volumio-sala smbd[959]: [2025/06/01 08:28:03.034607, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 01 08:28:03 volumio-sala smbd[959]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 01 08:28:03 volumio-sala smbd[901]: [2025/06/01 08:28:03.019367, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 01 08:28:03 volumio-sala smbd[901]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 01 08:28:03 volumio-sala smbd[901]: [2025/06/01 08:28:03.033685, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 01 08:28:03 volumio-sala smbd[901]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 01 08:28:03 volumio-sala smbd[901]: [2025/06/01 08:28:03.034607, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 01 08:28:03 volumio-sala smbd[901]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 01 08:28:03 volumio-sala systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Jun 01 08:28:03 volumio-sala systemd[1]: Starting Multi-User System. Jun 01 08:28:03 volumio-sala systemd[1]: Reached target Multi-User System. Jun 01 08:28:03 volumio-sala systemd[1]: Starting Graphical Interface. Jun 01 08:28:03 volumio-sala systemd[1]: Reached target Graphical Interface. Jun 01 08:28:03 volumio-sala systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 01 08:28:03 volumio-sala smbd[901]: . Jun 01 08:28:03 volumio-sala systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 01 08:28:03 volumio-sala systemd[1]: Startup finished in 14.331s (kernel) + 1min 34.691s (userspace) = 1min 49.022s. Jun 01 08:28:03 volumio-sala winbindd[985]: [2025/06/01 08:28:03.738783, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 01 08:28:03 volumio-sala winbindd[985]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Jun 01 08:28:04 volumio-sala systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Jun 01 08:28:04 volumio-sala systemd[1]: Stopping Xbindrc... Jun 01 08:28:04 volumio-sala systemd[1]: Starting Xbindrc... Jun 01 08:28:04 volumio-sala systemd[1]: xbindkeysrc.service start request repeated too quickly, refusing to start. Jun 01 08:28:04 volumio-sala systemd[1]: Failed to start Xbindrc. Jun 01 08:28:04 volumio-sala systemd[1]: Unit xbindkeysrc.service entered failed state. Jun 01 08:28:04 volumio-sala winbindd[988]: [2025/06/01 08:28:04.715036, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 01 08:28:04 volumio-sala winbindd[988]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Jun 01 08:28:05 volumio-sala smbd[979]: [2025/06/01 08:28:05.007355, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jun 01 08:28:05 volumio-sala smbd[979]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jun 01 08:28:05 volumio-sala smbd[989]: [2025/06/01 08:28:05.062151, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 01 08:28:05 volumio-sala smbd[989]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 01 08:28:07 volumio-sala volumio-remote-updater[602]: [2025-06-01 08:28:07] [connect] Successful connection Jun 01 08:28:11 volumio-sala volumio[854]: info: ------------------------------------------- Jun 01 08:28:11 volumio-sala volumio[854]: info: ----- Volumio2 ---- Jun 01 08:28:11 volumio-sala volumio[854]: info: ------------------------------------------- Jun 01 08:28:11 volumio-sala volumio[854]: info: ----- System startup ---- Jun 01 08:28:11 volumio-sala volumio[854]: info: ------------------------------------------- Jun 01 08:28:12 volumio-sala volumio[854]: info: MYVOLUMIO Environment detected Jun 01 08:28:18 volumio-sala volumio[854]: info: Plugin folders cleanup Jun 01 08:28:18 volumio-sala volumio[854]: info: Scanning into folder /volumio/app/plugins/ Jun 01 08:28:18 volumio-sala volumio[854]: info: Scanning category audio_interface Jun 01 08:28:18 volumio-sala volumio[854]: info: Scanning category miscellanea Jun 01 08:28:18 volumio-sala volumio[854]: info: Scanning category music_service Jun 01 08:28:18 volumio-sala volumio[854]: info: Scanning category plugins.json Jun 01 08:28:18 volumio-sala volumio[854]: info: Scanning category system_controller Jun 01 08:28:18 volumio-sala volumio[854]: info: Scanning category user_interface Jun 01 08:28:18 volumio-sala volumio[854]: info: Scanning into folder /data/plugins/ Jun 01 08:28:18 volumio-sala volumio[854]: info: Plugin folders cleanup completed Jun 01 08:28:18 volumio-sala volumio[854]: info: ------------------------------------------- Jun 01 08:28:18 volumio-sala volumio[854]: info: ----- Core plugins startup ---- Jun 01 08:28:18 volumio-sala volumio[854]: info: ------------------------------------------- Jun 01 08:28:18 volumio-sala volumio[854]: info: Loading plugins from folder /volumio/app/plugins/ Jun 01 08:28:18 volumio-sala volumio[854]: info: Adding plugin upnp to MyMusic Plugins Jun 01 08:28:18 volumio-sala volumio[854]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 01 08:28:18 volumio-sala volumio[854]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 01 08:28:18 volumio-sala volumio[854]: info: Loading plugins from folder /data/plugins/ Jun 01 08:28:18 volumio-sala volumio[854]: info: Loading plugin "system"... Jun 01 08:28:18 volumio-sala volumio[854]: info: Loading plugin "appearance"... Jun 01 08:28:22 volumio-sala volumio-remote-updater[602]: [2025-06-01 08:28:22] [connect] Successful connection Jun 01 08:28:25 volumio-sala dhcpcd[486]: eth0: probing for an IPv4LL address Jun 01 08:28:27 volumio-sala volumio[854]: info: Loading plugin "network"... Jun 01 08:28:27 volumio-sala volumio[854]: info: Refreshing Cached IP Addresses Jun 01 08:28:27 volumio-sala volumio[854]: info: Loading plugin "services"... Jun 01 08:28:27 volumio-sala sudo[1002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 01 08:28:27 volumio-sala volumio[854]: info: Loading plugin "alsa_controller"... Jun 01 08:28:27 volumio-sala sudo[1002]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 08:28:27 volumio-sala sudo[1004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 01 08:28:27 volumio-sala sudo[1002]: pam_unix(sudo:session): session closed for user root Jun 01 08:28:27 volumio-sala sudo[1004]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 08:28:27 volumio-sala sudo[1004]: pam_unix(sudo:session): session closed for user root Jun 01 08:28:28 volumio-sala volumio[854]: info: Loading plugin "wizard"... Jun 01 08:28:28 volumio-sala volumio[854]: info: Loading plugin "volumio_command_line_client"... Jun 01 08:28:28 volumio-sala volumio[854]: info: Loading plugin "upnp"... Jun 01 08:28:28 volumio-sala volumio[854]: info: [1748766508699] Starting Upmpd Daemon Jun 01 08:28:28 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 01 08:28:28 volumio-sala volumio[854]: info: Loading plugin "my_music"... Jun 01 08:28:28 volumio-sala volumio[854]: info: Loading plugin "mpd"... Jun 01 08:28:31 volumio-sala dhcpcd[486]: eth0: using IPv4LL address 169.254.140.236 Jun 01 08:28:31 volumio-sala dhcpcd[486]: eth0: adding host route to 169.254.140.236 via 127.0.0.1 Jun 01 08:28:31 volumio-sala dhcpcd[486]: eth0: adding route to 169.254.0.0/16 Jun 01 08:28:31 volumio-sala nmbd[899]: [2025/06/01 08:28:31.301009, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jun 01 08:28:31 volumio-sala nmbd[899]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jun 01 08:28:31 volumio-sala volumio[854]: info: Loading plugin "upnp_browser"... Jun 01 08:28:32 volumio-sala ntpd[700]: Listen normally on 4 eth0 169.254.140.236 UDP 123 Jun 01 08:28:32 volumio-sala ntpd[700]: peers refreshed Jun 01 08:28:34 volumio-sala volumio[854]: info: Loading plugin "networkfs"... Jun 01 08:28:35 volumio-sala kernel: smsc95xx 1-1.1:1.0 eth0: link down Jun 01 08:28:35 volumio-sala dhcpcd[486]: eth0: carrier lost Jun 01 08:28:35 volumio-sala dhcpcd[486]: eth0: deleting host route to 169.254.140.236 via 127.0.0.1 Jun 01 08:28:35 volumio-sala dhcpcd[486]: eth0: deleting route to 169.254.0.0/16 Jun 01 08:28:35 volumio-sala nmbd[899]: [2025/06/01 08:28:35.483896, 0] ../source3/libsmb/nmblib.c:873(send_udp) Jun 01 08:28:35 volumio-sala nmbd[899]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Jun 01 08:28:35 volumio-sala nmbd[899]: [2025/06/01 08:28:35.484519, 0] ../source3/nmbd/nmbd_packets.c:1638(retransmit_or_expire_response_records) Jun 01 08:28:35 volumio-sala nmbd[899]: retransmit_or_expire_response_records: Failed to resend packet id 24588 to IP 169.254.255.255 on subnet 169.254.140.236 Jun 01 08:28:35 volumio-sala nmbd[899]: [2025/06/01 08:28:35.484915, 0] ../source3/libsmb/nmblib.c:873(send_udp) Jun 01 08:28:35 volumio-sala nmbd[899]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Jun 01 08:28:35 volumio-sala nmbd[899]: [2025/06/01 08:28:35.485280, 0] ../source3/nmbd/nmbd_packets.c:1638(retransmit_or_expire_response_records) Jun 01 08:28:35 volumio-sala nmbd[899]: retransmit_or_expire_response_records: Failed to resend packet id 24589 to IP 169.254.255.255 on subnet 169.254.140.236 Jun 01 08:28:35 volumio-sala nmbd[899]: [2025/06/01 08:28:35.485653, 0] ../source3/libsmb/nmblib.c:873(send_udp) Jun 01 08:28:35 volumio-sala nmbd[899]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Jun 01 08:28:35 volumio-sala nmbd[899]: [2025/06/01 08:28:35.486010, 0] ../source3/nmbd/nmbd_packets.c:1638(retransmit_or_expire_response_records) Jun 01 08:28:35 volumio-sala nmbd[899]: retransmit_or_expire_response_records: Failed to resend packet id 24590 to IP 169.254.255.255 on subnet 169.254.140.236 Jun 01 08:28:35 volumio-sala nmbd[899]: [2025/06/01 08:28:35.498683, 0] ../source3/libsmb/nmblib.c:873(send_udp) Jun 01 08:28:35 volumio-sala nmbd[899]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Jun 01 08:28:35 volumio-sala nmbd[899]: [2025/06/01 08:28:35.499154, 0] ../source3/nmbd/nmbd_packets.c:1638(retransmit_or_expire_response_records) Jun 01 08:28:35 volumio-sala nmbd[899]: retransmit_or_expire_response_records: Failed to resend packet id 24591 to IP 169.254.255.255 on subnet 169.254.140.236 Jun 01 08:28:35 volumio-sala nmbd[899]: [2025/06/01 08:28:35.520259, 0] ../source3/libsmb/nmblib.c:873(send_udp) Jun 01 08:28:35 volumio-sala nmbd[899]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Jun 01 08:28:35 volumio-sala nmbd[899]: [2025/06/01 08:28:35.527534, 0] ../source3/nmbd/nmbd_packets.c:1638(retransmit_or_expire_response_records) Jun 01 08:28:35 volumio-sala nmbd[899]: retransmit_or_expire_response_records: Failed to resend packet id 24592 to IP 169.254.255.255 on subnet 169.254.140.236 Jun 01 08:28:35 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 01 08:28:35 volumio-sala volumio[854]: info: Loading plugin "alarm-clock"... Jun 01 08:28:35 volumio-sala sudo[1053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Enrico50,password=Ae505186,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.63/music /mnt/NAS/MUSICA Jun 01 08:28:35 volumio-sala sudo[1053]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 08:28:36 volumio-sala ifplugd(eth0)[691]: Link beat lost. Jun 01 08:28:36 volumio-sala kernel: FS-Cache: Netfs 'cifs' registered for caching Jun 01 08:28:36 volumio-sala kernel: Key type cifs.spnego registered Jun 01 08:28:36 volumio-sala kernel: Key type cifs.idmap registered Jun 01 08:28:36 volumio-sala kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Jun 01 08:28:36 volumio-sala kernel: CIFS VFS: Error connecting to socket. Aborting operation. Jun 01 08:28:36 volumio-sala kernel: CIFS VFS: cifs_mount failed w/return code = -101 Jun 01 08:28:36 volumio-sala sudo[1053]: pam_unix(sudo:session): session closed for user root Jun 01 08:28:36 volumio-sala ntpd[700]: Deleting interface #4 eth0, 169.254.140.236#123, interface stats: received=0, sent=0, dropped=0, active_time=4 secs Jun 01 08:28:36 volumio-sala ntpd[700]: peers refreshed Jun 01 08:28:36 volumio-sala kernel: smsc95xx 1-1.1:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0x41E1 Jun 01 08:28:36 volumio-sala dhcpcd[486]: eth0: carrier acquired Jun 01 08:28:36 volumio-sala dhcpcd[486]: eth0: soliciting an IPv6 router Jun 01 08:28:37 volumio-sala volumio-remote-updater[602]: [2025-06-01 08:28:37] [connect] Successful connection Jun 01 08:28:37 volumio-sala ifplugd(eth0)[691]: Link beat detected. Jun 01 08:28:37 volumio-sala volumio[854]: info: Loading plugin "airplay_emulation"... Jun 01 08:28:37 volumio-sala volumio[854]: info: Starting Shairport Sync Jun 01 08:28:37 volumio-sala volumio[854]: info: Loading plugin "last_100"... Jun 01 08:28:37 volumio-sala volumio[854]: info: Loading plugin "webradio"... Jun 01 08:28:38 volumio-sala volumio[854]: info: Loading plugin "i2s_dacs"... Jun 01 08:28:38 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 08:28:38 volumio-sala volumio[854]: info: Loading plugin "volumiodiscovery"... Jun 01 08:28:39 volumio-sala volumio[854]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 01 08:28:39 volumio-sala node[854]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 01 08:28:39 volumio-sala node[854]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 01 08:28:39 volumio-sala node[854]: *** WARNING *** For more information see Jun 01 08:28:39 volumio-sala node[854]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 01 08:28:39 volumio-sala node[854]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 01 08:28:39 volumio-sala node[854]: *** WARNING *** For more information see Jun 01 08:28:39 volumio-sala volumio[854]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 01 08:28:39 volumio-sala volumio[854]: *** WARNING *** For more information see Jun 01 08:28:39 volumio-sala volumio[854]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 01 08:28:39 volumio-sala volumio[854]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 01 08:28:39 volumio-sala volumio[854]: *** WARNING *** For more information see Jun 01 08:28:39 volumio-sala volumio[854]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 01 08:28:39 volumio-sala volumio[854]: Discovery: StartAdv! undefined Jun 01 08:28:39 volumio-sala volumio[854]: Discovery: Started advertising... Volumio-sala - undefined Jun 01 08:28:39 volumio-sala dbus[639]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' Jun 01 08:28:39 volumio-sala systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jun 01 08:28:39 volumio-sala avahi-daemon[1081]: Found user 'avahi' (UID 104) and group 'avahi' (GID 106). Jun 01 08:28:39 volumio-sala avahi-daemon[1081]: Successfully dropped root privileges. Jun 01 08:28:39 volumio-sala avahi-daemon[1081]: avahi-daemon 0.6.31 starting up. Jun 01 08:28:39 volumio-sala dbus[639]: [system] Successfully activated service 'org.freedesktop.Avahi' Jun 01 08:28:39 volumio-sala systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jun 01 08:28:39 volumio-sala avahi-daemon[1081]: Successfully called chroot(). Jun 01 08:28:39 volumio-sala avahi-daemon[1081]: Successfully dropped remaining capabilities. Jun 01 08:28:39 volumio-sala avahi-daemon[1081]: Loading service file /services/volumio.service. Jun 01 08:28:39 volumio-sala avahi-daemon[1081]: Network interface enumeration completed. Jun 01 08:28:39 volumio-sala avahi-daemon[1081]: Registering HINFO record with values 'ARMV6L'/'LINUX'. Jun 01 08:28:39 volumio-sala avahi-daemon[1081]: Server startup complete. Host name is volumio-sala.local. Local service cookie is 1889804276. Jun 01 08:28:39 volumio-sala avahi-daemon[1081]: Service "Volumio sala" (/services/volumio.service) successfully established. Jun 01 08:28:39 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 01 08:28:39 volumio-sala volumio[854]: info: Loading plugin "outputs"... Jun 01 08:28:39 volumio-sala volumio[854]: info: Loading plugin "albumart"... Jun 01 08:28:39 volumio-sala volumio[854]: info: Plugin example_plugin is not enabled Jun 01 08:28:39 volumio-sala volumio[854]: info: Loading plugin "inputs"... Jun 01 08:28:39 volumio-sala volumio[854]: info: Loading plugin "updater_comm"... Jun 01 08:28:41 volumio-sala dhcpcd[486]: eth0: using IPv4LL address 169.254.140.236 Jun 01 08:28:41 volumio-sala dhcpcd[486]: eth0: adding host route to 169.254.140.236 via 127.0.0.1 Jun 01 08:28:41 volumio-sala dhcpcd[486]: eth0: adding route to 169.254.0.0/16 Jun 01 08:28:41 volumio-sala avahi-daemon[1081]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.140.236. Jun 01 08:28:41 volumio-sala avahi-daemon[1081]: New relevant interface eth0.IPv4 for mDNS. Jun 01 08:28:41 volumio-sala avahi-daemon[1081]: Registering new address record for 169.254.140.236 on eth0.IPv4. Jun 01 08:28:41 volumio-sala volumio[854]: info: Plugin mpdemulation is not enabled Jun 01 08:28:42 volumio-sala volumio[854]: info: Loading plugin "rest_api"... Jun 01 08:28:42 volumio-sala volumio[854]: info: Loading plugin "websocket"... Jun 01 08:28:42 volumio-sala volumio[854]: info: ___________ START PLUGINS ___________ Jun 01 08:28:42 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 01 08:28:42 volumio-sala volumio[854]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 01 08:28:42 volumio-sala volumio[854]: info: [1748766522883] CoreMusicLibrary::Adding element Media Servers Jun 01 08:28:42 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 01 08:28:43 volumio-sala ntpd[700]: Listen normally on 5 eth0 169.254.140.236 UDP 123 Jun 01 08:28:43 volumio-sala ntpd[700]: peers refreshed Jun 01 08:28:43 volumio-sala volumio[854]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 01 08:28:43 volumio-sala volumio[854]: Forking 1 albumart workers Jun 01 08:28:44 volumio-sala volumio[854]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 01 08:28:44 volumio-sala volumio[854]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 01 08:28:44 volumio-sala volumio[854]: info: [1748766524049] CoreMusicLibrary::Adding element Last_100 Jun 01 08:28:44 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 01 08:28:44 volumio-sala volumio[854]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 01 08:28:44 volumio-sala volumio[854]: info: [1748766524097] CoreMusicLibrary::Adding element Webradio Jun 01 08:28:44 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 01 08:28:44 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 08:28:44 volumio-sala volumio[854]: info: ------------------------------------------- Jun 01 08:28:44 volumio-sala volumio[854]: info: ----- MyVolumio plugins startup ---- Jun 01 08:28:44 volumio-sala volumio[854]: info: ------------------------------------------- Jun 01 08:28:44 volumio-sala volumio[854]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 01 08:28:44 volumio-sala volumio[854]: info: Loading i18n strings for locale it Jun 01 08:28:44 volumio-sala volumio[854]: Updating browse sources language Jun 01 08:28:44 volumio-sala volumio[854]: Cannot find translation for sourceMedia Servers Jun 01 08:28:44 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 01 08:28:44 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 01 08:28:44 volumio-sala volumio[854]: info: CoreCommandRouter::initPlayerControls Jun 01 08:28:44 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 08:28:45 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jun 01 08:28:45 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 08:28:45 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 08:28:45 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 08:28:45 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 08:28:45 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 08:28:45 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 01 08:28:45 volumio-sala volumio[854]: info: BOOT COMPLETED Jun 01 08:28:45 volumio-sala volumio[854]: [Metrics] CommandRouter: 33s 846.56ms Jun 01 08:28:45 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 08:28:46 volumio-sala dhcpcd[486]: eth0: soliciting a DHCP lease Jun 01 08:28:46 volumio-sala dhcpcd[486]: eth0: offered 192.168.1.161 from 192.168.1.1 Jun 01 08:28:49 volumio-sala volumio[854]: Starting albumart workers Jun 01 08:28:51 volumio-sala volumio[854]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jun 01 08:28:51 volumio-sala volumio[854]: info: CoreCommandRouter::Close All Modals sent Jun 01 08:28:51 volumio-sala volumio[854]: info: CoreCommandRouter::Close All Modals sent Jun 01 08:28:51 volumio-sala volumio[854]: Express server listening on port 3000 Jun 01 08:28:51 volumio-sala volumio[854]: [Metrics] WebUI: 44s 516.13ms Jun 01 08:28:51 volumio-sala volumio[854]: Volumio Calling Home Jun 01 08:28:51 volumio-sala dhcpcd[486]: eth0: leased 192.168.1.161 for 86400 seconds Jun 01 08:28:51 volumio-sala avahi-daemon[1081]: Registering new address record for 192.168.1.161 on eth0.IPv4. Jun 01 08:28:51 volumio-sala avahi-daemon[1081]: Withdrawing address record for 169.254.140.236 on eth0. Jun 01 08:28:51 volumio-sala avahi-daemon[1081]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.140.236. Jun 01 08:28:51 volumio-sala dhcpcd[486]: eth0: adding host route to 192.168.1.161 via 127.0.0.1 Jun 01 08:28:51 volumio-sala avahi-daemon[1081]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.161. Jun 01 08:28:51 volumio-sala dhcpcd[486]: eth0: adding route to 192.168.1.0/24 Jun 01 08:28:51 volumio-sala dhcpcd[486]: eth0: adding default route via 192.168.1.1 Jun 01 08:28:51 volumio-sala dhcpcd[486]: eth0: deleting host route to 169.254.140.236 via 127.0.0.1 Jun 01 08:28:51 volumio-sala dhcpcd[486]: eth0: deleting route to 169.254.0.0/16 Jun 01 08:28:52 volumio-sala volumio-remote-updater[602]: [2025-06-01 08:28:52] [connect] Successful connection Jun 01 08:28:52 volumio-sala volumio[854]: info: CoreStateMachine::resetVolumioState Jun 01 08:28:52 volumio-sala volumio[854]: info: CoreStateMachine::getcurrentVolume Jun 01 08:28:52 volumio-sala volumio[854]: info: CoreCommandRouter::volumioRetrievevolume Jun 01 08:28:53 volumio-sala ntpd[700]: Listen normally on 6 eth0 192.168.1.161 UDP 123 Jun 01 08:28:53 volumio-sala ntpd[700]: Deleting interface #5 eth0, 169.254.140.236#123, interface stats: received=0, sent=0, dropped=0, active_time=10 secs Jun 01 08:28:53 volumio-sala ntpd[700]: peers refreshed Jun 01 08:28:54 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 01 08:28:54 volumio-sala sudo[1147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 01 08:28:54 volumio-sala sudo[1147]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 08:28:54 volumio-sala sudo[1147]: pam_unix(sudo:session): session closed for user root Jun 01 08:28:54 volumio-sala sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 01 08:28:54 volumio-sala sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 08:28:54 volumio-sala sudo[1149]: pam_unix(sudo:session): session closed for user root Jun 01 08:28:54 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jun 01 08:28:54 volumio-sala volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 01 08:28:57 volumio-sala volumio[854]: info: Setting Device type: Raspberry PI Jun 01 08:28:57 volumio-sala volumio[854]: info: Cannot mount NAS MUSICA at system boot, trial number 1 ,retrying in 5 seconds Jun 01 08:28:57 volumio-sala volumio[854]: info: MPD running with PID635 Jun 01 08:28:57 volumio-sala volumio[854]: ,establishing connection Jun 01 08:28:57 volumio-sala volumio[854]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 08:28:57 volumio-sala volumio[854]: { Error: addMembership ENODEV Jun 01 08:28:57 volumio-sala volumio[854]: at _errnoException (util.js:1022:11) Jun 01 08:28:57 volumio-sala volumio[854]: at Socket.addMembership (dgram.js:615:11) Jun 01 08:28:57 volumio-sala volumio[854]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:264:16) Jun 01 08:28:57 volumio-sala volumio[854]: at ontimeout (timers.js:482:11) Jun 01 08:28:57 volumio-sala volumio[854]: at tryOnTimeout (timers.js:317:5) Jun 01 08:28:57 volumio-sala volumio[854]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } Jun 01 08:28:57 volumio-sala volumio[854]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 08:29:02 volumio-sala sudo[1201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-01 08:28 Jun 01 08:29:02 volumio-sala sudo[1201]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="b9cd485c2d7861a79d18f42ff0fdb052338b2239" VOLUMIO_FE_VERSION="002b92c82c889cd6d6dba7b53841c5ae23bbbe3e" VOLUMIO_BE_VERSION="7d2ba3a94da666f8c268b206dcaf6a466691b221" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Jun 8 18:17:29 CEST 2020" VOLUMIO_VERSION="2.779" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="d3e1021b8bd596622d29cc9abe301111"