-- Logs begin at Wed 2024-04-24 05:11:21 UTC, end at Wed 2024-04-24 05:13:07 UTC. -- Apr 24 05:12:05 volumio volumio-remote-updater[561]: [2024-04-24 05:12:05] [info] asio async_connect error: system:111 (Connection refused) Apr 24 05:12:05 volumio volumio-remote-updater[561]: [2024-04-24 05:12:05] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 24 05:12:05 volumio volumio-remote-updater[561]: [2024-04-24 05:12:05] [error] handle_connect error: Underlying Transport Error Apr 24 05:12:05 volumio smbd[869]: Starting SMB/CIFS daemon: smbd[2024/04/24 05:12:05, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 24 05:12:05 volumio smbd[869]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 24 05:12:05 volumio smbd[869]: [2024/04/24 05:12:05, 0] ../lib/util/util.c:220(directory_create_or_exist) Apr 24 05:12:05 volumio smbd[869]: mkdir failed on directory /var/log/samba/cores: No such file or directory Apr 24 05:12:05 volumio smbd[869]: [2024/04/24 05:12:05, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Apr 24 05:12:05 volumio smbd[869]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 24 05:12:05 volumio smbd[869]: [2024/04/24 05:12:05, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Apr 24 05:12:05 volumio smbd[869]: Unable to setup corepath for smbd: No such file or directory Apr 24 05:12:05 volumio smbd[869]: [2024/04/24 05:12:05, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 24 05:12:05 volumio smbd[869]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 24 05:12:05 volumio smbd[869]: [2024/04/24 05:12:05, 0] ../source3/smbd/server.c:1241(main) Apr 24 05:12:05 volumio smbd[869]: smbd version 4.2.14-Debian started. Apr 24 05:12:05 volumio smbd[869]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Apr 24 05:12:05 volumio smbd[888]: [2024/04/24 05:12:05.689428, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 24 05:12:05 volumio smbd[869]: [2024/04/24 05:12:05.689428, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 24 05:12:05 volumio smbd[888]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 24 05:12:05 volumio smbd[888]: [2024/04/24 05:12:05.703542, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 24 05:12:05 volumio smbd[888]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 24 05:12:05 volumio smbd[888]: [2024/04/24 05:12:05.703750, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 24 05:12:05 volumio smbd[888]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 24 05:12:05 volumio smbd[869]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 24 05:12:05 volumio smbd[869]: [2024/04/24 05:12:05.703542, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 24 05:12:05 volumio smbd[869]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 24 05:12:05 volumio smbd[869]: [2024/04/24 05:12:05.703750, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 24 05:12:05 volumio smbd[869]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 24 05:12:05 volumio smbd[869]: . Apr 24 05:12:05 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Apr 24 05:12:06 volumio winbindd[903]: [2024/04/24 05:12:06.132181, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 24 05:12:06 volumio winbindd[903]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Apr 24 05:12:06 volumio winbindd[904]: [2024/04/24 05:12:06.455688, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 24 05:12:06 volumio winbindd[904]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Apr 24 05:12:06 volumio smbd[900]: [2024/04/24 05:12:06.637135, 0] ../lib/util/become_daemon.c:124(daemon_ready) Apr 24 05:12:06 volumio smbd[900]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 24 05:12:06 volumio smbd[905]: [2024/04/24 05:12:06.671955, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 24 05:12:06 volumio smbd[905]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 24 05:12:12 volumio volumio[823]: info: ------------------------------------------- Apr 24 05:12:12 volumio volumio[823]: info: ----- Volumio2 ---- Apr 24 05:12:12 volumio volumio[823]: info: ------------------------------------------- Apr 24 05:12:12 volumio volumio[823]: info: ----- System startup ---- Apr 24 05:12:12 volumio volumio[823]: info: ------------------------------------------- Apr 24 05:12:15 volumio volumio-remote-updater[561]: [2024-04-24 05:12:15] [connect] Successful connection Apr 24 05:12:16 volumio udisks-glue[559]: error: Timeout Apr 24 05:12:16 volumio udisks-glue[559]: error: Timeout Apr 24 05:12:19 volumio dbus[623]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' Apr 24 05:12:19 volumio systemd[1]: Starting Bluetooth service... Apr 24 05:12:19 volumio systemd[1]: Started Music Player Daemon. Apr 24 05:12:19 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Apr 24 05:12:20 volumio bluetoothd[950]: Bluetooth daemon 5.23 Apr 24 05:12:20 volumio dbus[623]: [system] Successfully activated service 'org.bluez' Apr 24 05:12:20 volumio systemd[1]: Started Bluetooth service. Apr 24 05:12:20 volumio kernel: Bluetooth: Core ver 2.19 Apr 24 05:12:20 volumio kernel: NET: Registered protocol family 31 Apr 24 05:12:20 volumio kernel: Bluetooth: HCI device and connection manager initialized Apr 24 05:12:20 volumio kernel: Bluetooth: HCI socket layer initialized Apr 24 05:12:20 volumio kernel: Bluetooth: L2CAP socket layer initialized Apr 24 05:12:20 volumio kernel: Bluetooth: SCO socket layer initialized Apr 24 05:12:20 volumio bluetoothd[950]: Starting SDP server Apr 24 05:12:20 volumio bluetoothd[950]: Excluding (cli) sap Apr 24 05:12:20 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Apr 24 05:12:20 volumio kernel: Bluetooth: BNEP filters: protocol multicast Apr 24 05:12:20 volumio kernel: Bluetooth: BNEP socket layer initialized Apr 24 05:12:20 volumio bluetoothd[950]: Bluetooth management interface 1.7 initialized Apr 24 05:12:20 volumio dbus[623]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' Apr 24 05:12:20 volumio systemd[1]: Starting Hostname Service... Apr 24 05:12:21 volumio systemd-hostnamed[967]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname! Apr 24 05:12:21 volumio dbus[623]: [system] Successfully activated service 'org.freedesktop.hostname1' Apr 24 05:12:21 volumio systemd[1]: Started Hostname Service. Apr 24 05:12:21 volumio kernel: cgroup: new mount options do not match the existing superblock, will be ignored Apr 24 05:12:21 volumio volumio[823]: info: MYVOLUMIO Environment detected Apr 24 05:12:22 volumio volumio[823]: info: Plugin folders cleanup Apr 24 05:12:22 volumio volumio[823]: info: Scanning into folder /volumio/app/plugins/ Apr 24 05:12:22 volumio volumio[823]: info: Scanning category audio_interface Apr 24 05:12:22 volumio volumio[823]: info: Scanning category miscellanea Apr 24 05:12:22 volumio sudo[977]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/cset shield -r Apr 24 05:12:22 volumio volumio[823]: info: Scanning category music_service Apr 24 05:12:22 volumio volumio[823]: info: Scanning category plugins.json Apr 24 05:12:22 volumio sudo[977]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 05:12:22 volumio volumio[823]: info: Scanning category system_controller Apr 24 05:12:22 volumio volumio[823]: info: Scanning category user_interface Apr 24 05:12:22 volumio volumio[823]: info: Scanning into folder /data/plugins/ Apr 24 05:12:22 volumio volumio[823]: info: Scanning category audio_interface Apr 24 05:12:22 volumio volumio[823]: info: Scanning category miscellanea Apr 24 05:12:22 volumio volumio[823]: info: Scanning category music_service Apr 24 05:12:22 volumio volumio[823]: info: Scanning category system_controller Apr 24 05:12:22 volumio volumio[823]: info: Plugin folders cleanup completed Apr 24 05:12:22 volumio volumio[823]: info: ------------------------------------------- Apr 24 05:12:22 volumio volumio[823]: info: ----- Core plugins startup ---- Apr 24 05:12:22 volumio volumio[823]: info: ------------------------------------------- Apr 24 05:12:22 volumio volumio[823]: info: Loading plugins from folder /volumio/app/plugins/ Apr 24 05:12:22 volumio volumio[823]: info: Adding plugin upnp to MyMusic Plugins Apr 24 05:12:22 volumio volumio[823]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 24 05:12:22 volumio volumio[823]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 24 05:12:22 volumio volumio[823]: info: Loading plugins from folder /data/plugins/ Apr 24 05:12:22 volumio volumio[823]: info: Loading plugin "system"... Apr 24 05:12:22 volumio volumio[823]: info: Loading plugin "appearance"... Apr 24 05:12:22 volumio sudo[977]: pam_unix(sudo:session): session closed for user root Apr 24 05:12:23 volumio volumio[953]: cset: **> shielding not active on system Apr 24 05:12:23 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Apr 24 05:12:23 volumio systemd[1]: Starting Multi-User System. Apr 24 05:12:23 volumio systemd[1]: Reached target Multi-User System. Apr 24 05:12:23 volumio systemd[1]: Starting Graphical Interface. Apr 24 05:12:23 volumio systemd[1]: Reached target Graphical Interface. Apr 24 05:12:23 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 24 05:12:23 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 24 05:12:23 volumio systemd[1]: Startup finished in 13.618s (kernel) + 1min 3.185s (userspace) = 1min 16.804s. Apr 24 05:12:23 volumio kernel: eth0: Link auto-negotiation speed 1000M bps full duplex Apr 24 05:12:24 volumio ifplugd(eth0)[662]: Link beat detected. Apr 24 05:12:24 volumio ifplugd(eth0)[662]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Apr 24 05:12:24 volumio ifplugd(eth0)[662]: client: command failed: No such device (-19) Apr 24 05:12:24 volumio ifplugd(eth0)[662]: client: dhcpcd[1033]: version 6.0.5 starting Apr 24 05:12:24 volumio dhcpcd[1033]: version 6.0.5 starting Apr 24 05:12:25 volumio dhcpcd[1033]: eth0: soliciting a DHCP lease Apr 24 05:12:25 volumio ifplugd(eth0)[662]: client: dhcpcd[1033]: eth0: soliciting a DHCP lease Apr 24 05:12:28 volumio dhcpcd[1033]: eth0: offered 192.168.50.109 from 192.168.50.1 Apr 24 05:12:28 volumio ifplugd(eth0)[662]: client: dhcpcd[1033]: eth0: offered 192.168.50.109 from 192.168.50.1 Apr 24 05:12:28 volumio dhcpcd[1033]: eth0: leased 192.168.50.109 for 86400 seconds Apr 24 05:12:28 volumio ifplugd(eth0)[662]: client: dhcpcd[1033]: eth0: leased 192.168.50.109 for 86400 seconds Apr 24 05:12:28 volumio avahi-daemon[614]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.50.109. Apr 24 05:12:28 volumio avahi-daemon[614]: New relevant interface eth0.IPv4 for mDNS. Apr 24 05:12:28 volumio avahi-daemon[614]: Registering new address record for 192.168.50.109 on eth0.IPv4. Apr 24 05:12:28 volumio dhcpcd[1033]: eth0: adding host route to 192.168.50.109 via 127.0.0.1 Apr 24 05:12:28 volumio ifplugd(eth0)[662]: client: dhcpcd[1033]: eth0: adding host route to 192.168.50.109 via 127.0.0.1 Apr 24 05:12:28 volumio dhcpcd[1033]: eth0: adding route to 192.168.50.0/24 Apr 24 05:12:28 volumio ifplugd(eth0)[662]: client: dhcpcd[1033]: eth0: adding route to 192.168.50.0/24 Apr 24 05:12:28 volumio dhcpcd[1033]: eth0: adding default route via 192.168.50.1 Apr 24 05:12:28 volumio ifplugd(eth0)[662]: client: dhcpcd[1033]: eth0: adding default route via 192.168.50.1 Apr 24 05:12:28 volumio dhcpcd[1033]: forked to background, child pid 1079 Apr 24 05:12:28 volumio ifplugd(eth0)[662]: client: dhcpcd[1033]: forked to background, child pid 1079 Apr 24 05:12:30 volumio volumio-remote-updater[561]: [2024-04-24 05:12:30] [connect] Successful connection Apr 24 05:12:30 volumio ntpd[711]: Listen normally on 3 eth0 192.168.50.109 UDP 123 Apr 24 05:12:30 volumio ntpd[711]: peers refreshed Apr 24 05:12:30 volumio systemd[1]: Reloading OpenBSD Secure Shell server. Apr 24 05:12:30 volumio sshd[730]: Received SIGHUP; restarting. Apr 24 05:12:30 volumio systemd[1]: Reloaded OpenBSD Secure Shell server. Apr 24 05:12:30 volumio sshd[730]: Server listening on 0.0.0.0 port 22. Apr 24 05:12:30 volumio sshd[730]: Server listening on :: port 22. Apr 24 05:12:31 volumio ifplugd(eth0)[662]: Program executed successfully. Apr 24 05:12:32 volumio ntpd_intres[768]: DNS 0.debian.pool.ntp.org -> 10.0.0.1 Apr 24 05:12:32 volumio ntpd_intres[768]: DNS 1.debian.pool.ntp.org -> 10.0.0.1 Apr 24 05:12:32 volumio ntpd_intres[768]: DNS 2.debian.pool.ntp.org -> 10.0.0.1 Apr 24 05:12:32 volumio ntpd_intres[768]: DNS 3.debian.pool.ntp.org -> 10.0.0.1 Apr 24 05:12:32 volumio nmbd[867]: [2024/04/24 05:12:32.783738, 0] ../lib/util/become_daemon.c:124(daemon_ready) Apr 24 05:12:32 volumio nmbd[867]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 24 05:12:34 volumio volumio[823]: info: Loading plugin "network"... Apr 24 05:12:34 volumio volumio[823]: info: Refreshing Cached IP Addresses Apr 24 05:12:34 volumio volumio[823]: info: Loading plugin "peppy_screensaver"... Apr 24 05:12:35 volumio sudo[1181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 24 05:12:35 volumio sudo[1181]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 05:12:35 volumio sudo[1181]: pam_unix(sudo:session): session closed for user root Apr 24 05:12:35 volumio sudo[1185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 05:12:35 volumio sudo[1185]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 05:12:35 volumio sudo[1185]: pam_unix(sudo:session): session closed for user root Apr 24 05:12:38 volumio volumio[823]: info: Applying required configuration parameters for plugin peppy_screensaver Apr 24 05:12:38 volumio volumio[823]: info: Loading plugin "services"... Apr 24 05:12:38 volumio volumio[823]: info: Loading plugin "alsa_controller"... Apr 24 05:12:38 volumio volumio[823]: info: Loading plugin "wizard"... Apr 24 05:12:38 volumio volumio[823]: info: Loading plugin "volumio_command_line_client"... Apr 24 05:12:38 volumio volumio[823]: info: Loading plugin "upnp"... Apr 24 05:12:38 volumio volumio[823]: info: [1713935558844] Starting Upmpd Daemon Apr 24 05:12:38 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 24 05:12:38 volumio volumio[823]: info: Loading plugin "my_music"... Apr 24 05:12:38 volumio volumio[823]: info: Loading plugin "mpd"... Apr 24 05:12:39 volumio volumio[823]: info: Loading plugin "upnp_browser"... Apr 24 05:12:41 volumio volumio[823]: info: Loading plugin "networkfs"... Apr 24 05:12:41 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 24 05:12:41 volumio volumio[823]: info: Loading plugin "alarm-clock"... Apr 24 05:12:41 volumio sudo[1228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Music,password=tramTU73,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //Hoangs-mac-mini/music /mnt/NAS/Music Apr 24 05:12:41 volumio sudo[1228]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 05:12:41 volumio kernel: Key type dns_resolver registered Apr 24 05:12:41 volumio kernel: FS-Cache: Netfs 'cifs' registered for caching Apr 24 05:12:41 volumio kernel: Key type cifs.spnego registered Apr 24 05:12:41 volumio kernel: Key type cifs.idmap registered Apr 24 05:12:42 volumio volumio[823]: info: Loading plugin "airplay_emulation"... Apr 24 05:12:42 volumio volumio[823]: info: Starting Shairport Sync Apr 24 05:12:42 volumio volumio[823]: info: Loading plugin "last_100"... Apr 24 05:12:42 volumio volumio[823]: info: Loading plugin "webradio"... Apr 24 05:12:42 volumio volumio[823]: info: Loading plugin "i2s_dacs"... Apr 24 05:12:42 volumio volumio[823]: info: I2S DAC not set, start Auto-detection Apr 24 05:12:42 volumio volumio[823]: info: Loading plugin "volumiodiscovery"... Apr 24 05:12:42 volumio volumio[823]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 24 05:12:42 volumio node[823]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 24 05:12:42 volumio volumio[823]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 24 05:12:42 volumio node[823]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 24 05:12:42 volumio node[823]: *** WARNING *** For more information see Apr 24 05:12:42 volumio node[823]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 24 05:12:42 volumio node[823]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 24 05:12:42 volumio node[823]: *** WARNING *** For more information see Apr 24 05:12:42 volumio volumio[823]: *** WARNING *** For more information see Apr 24 05:12:42 volumio volumio[823]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 24 05:12:42 volumio volumio[823]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 24 05:12:42 volumio volumio[823]: *** WARNING *** For more information see Apr 24 05:12:42 volumio volumio[823]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 24 05:12:42 volumio volumio[823]: Discovery: StartAdv! undefined Apr 24 05:12:42 volumio volumio[823]: Discovery: Started advertising... Volumio - undefined Apr 24 05:12:42 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 24 05:12:42 volumio volumio[823]: info: Plugin volsimpleequal is not enabled Apr 24 05:12:42 volumio volumio[823]: info: Plugin autostart is not enabled Apr 24 05:12:42 volumio volumio[823]: info: Plugin music_services_shield is not enabled Apr 24 05:12:42 volumio volumio[823]: info: Plugin now_playing is not enabled Apr 24 05:12:42 volumio volumio[823]: info: Loading plugin "youtube2"... Apr 24 05:12:45 volumio volumio-remote-updater[561]: [2024-04-24 05:12:45] [connect] Successful connection Apr 24 05:12:51 volumio sudo[1228]: pam_unix(sudo:session): session closed for user root Apr 24 05:12:51 volumio kernel: CIFS VFS: Error connecting to socket. Aborting operation. Apr 24 05:12:51 volumio kernel: CIFS VFS: cifs_mount failed w/return code = -115 Apr 24 05:12:53 volumio volumio[823]: info: Loading plugin "outputs"... Apr 24 05:12:53 volumio volumio[823]: info: Loading plugin "albumart"... Apr 24 05:12:53 volumio volumio[823]: info: Plugin example_plugin is not enabled Apr 24 05:12:53 volumio volumio[823]: info: Loading plugin "inputs"... Apr 24 05:12:53 volumio volumio[823]: info: Loading plugin "updater_comm"... Apr 24 05:12:53 volumio volumio[823]: info: Plugin mpdemulation is not enabled Apr 24 05:12:53 volumio volumio[823]: info: Loading plugin "rest_api"... Apr 24 05:12:53 volumio volumio[823]: info: Loading plugin "websocket"... Apr 24 05:12:54 volumio volumio[823]: info: Plugin Systeminfo is not enabled Apr 24 05:12:54 volumio volumio[823]: info: Loading plugin "minidlna"... Apr 24 05:12:54 volumio volumio[823]: Forking 1 albumart workers Apr 24 05:12:54 volumio volumio[823]: info: Applying required configuration parameters for plugin minidlna Apr 24 05:12:54 volumio kernel: eth0: failed to detect cable link Apr 24 05:12:54 volumio dhcpcd[1079]: eth0: carrier lost Apr 24 05:12:54 volumio dhcpcd[1079]: eth0: deleting host route to 192.168.50.109 via 127.0.0.1 Apr 24 05:12:54 volumio dhcpcd[1079]: eth0: deleting route to 192.168.50.0/24 Apr 24 05:12:54 volumio dhcpcd[1079]: eth0: deleting default route via 192.168.50.1 Apr 24 05:12:54 volumio avahi-daemon[614]: Withdrawing address record for 192.168.50.109 on eth0. Apr 24 05:12:54 volumio avahi-daemon[614]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.50.109. Apr 24 05:12:54 volumio avahi-daemon[614]: Interface eth0.IPv4 no longer relevant for mDNS. Apr 24 05:12:55 volumio volumio[823]: info: Loading plugin "lms"... Apr 24 05:12:55 volumio ifplugd(eth0)[662]: Link beat lost. Apr 24 05:12:55 volumio volumio[823]: info: Loading plugin "squeezelite"... Apr 24 05:12:56 volumio ntpd[711]: Deleting interface #3 eth0, 192.168.50.109#123, interface stats: received=0, sent=1, dropped=0, active_time=26 secs Apr 24 05:12:56 volumio ntpd[711]: 10.0.0.1 interface 192.168.50.109 -> (none) Apr 24 05:12:56 volumio ntpd[711]: peers refreshed Apr 24 05:12:56 volumio volumio[823]: info: [Squeezelite] Initiated plugin Apr 24 05:12:56 volumio volumio[823]: info: Loading plugin "backup_restore"... Apr 24 05:12:56 volumio volumio[823]: Starting albumart workers Apr 24 05:12:57 volumio volumio[823]: info: ___________ START PLUGINS ___________ Apr 24 05:12:57 volumio volumio[823]: info: Loading i18n strings for locale en Apr 24 05:12:57 volumio volumio[823]: info: /tmp/myfifo created Apr 24 05:12:57 volumio sudo[1272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 Apr 24 05:12:57 volumio sudo[1272]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 05:12:57 volumio sudo[1272]: pam_unix(sudo:session): session closed for user root Apr 24 05:12:57 volumio volumio[823]: info: snd-dummy loaded Apr 24 05:12:57 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 05:12:57 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 05:12:57 volumio volumio[823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 05:12:57 volumio volumio[823]: info: [1713935577871] CoreMusicLibrary::Adding element Media Servers Apr 24 05:12:57 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 05:12:57 volumio sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /data/configuration/miscellanea/peppy_screensaver/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Apr 24 05:12:57 volumio sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 05:12:57 volumio sudo[1286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /data/configuration/miscellanea/peppy_screensaver/shairport-sync.conf.tmpl /volumio/app/plugins/music_service/airplay_emulation/shairport-sync.conf.tmpl Apr 24 05:12:57 volumio sudo[1286]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 05:12:57 volumio sudo[1282]: pam_unix(sudo:session): session closed for user root Apr 24 05:12:57 volumio sudo[1286]: pam_unix(sudo:session): session closed for user root Apr 24 05:12:58 volumio volumio[823]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 05:12:58 volumio volumio[823]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 24 05:12:58 volumio volumio[823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 05:12:58 volumio volumio[823]: info: [1713935578361] CoreMusicLibrary::Adding element Last_100 Apr 24 05:12:58 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 05:12:58 volumio volumio[823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 05:12:58 volumio volumio[823]: info: [1713935578378] CoreMusicLibrary::Adding element Webradio Apr 24 05:12:58 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 05:12:58 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 24 05:12:58 volumio volumio[823]: info: [youtube2-auth] Starting auth flow... Apr 24 05:12:58 volumio volumio[823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 24 05:12:58 volumio volumio[823]: info: [1713935578672] CoreMusicLibrary::Adding element YouTube2 Apr 24 05:12:58 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 05:12:58 volumio volumio[823]: info: Loading i18n strings for locale en Apr 24 05:12:58 volumio volumio[823]: info: ------------------------------------------- Apr 24 05:12:58 volumio sudo[1304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart logitechmediaserver Apr 24 05:12:58 volumio sudo[1304]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 05:12:58 volumio volumio[823]: info: ----- MyVolumio plugins startup ---- Apr 24 05:12:58 volumio volumio[823]: info: ------------------------------------------- Apr 24 05:12:58 volumio volumio[823]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 24 05:12:58 volumio volumio[823]: info: Loading i18n strings for locale en Apr 24 05:12:58 volumio systemd[1]: Starting Logitech Media Server Daemon... Apr 24 05:12:59 volumio sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 24 05:12:59 volumio sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 05:12:59 volumio volumio[823]: Updating browse sources language Apr 24 05:12:59 volumio volumio[823]: Cannot find translation for sourceMedia Servers Apr 24 05:12:59 volumio volumio[823]: Cannot find translation for sourceYouTube2 Apr 24 05:12:59 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 24 05:12:59 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 05:12:59 volumio volumio[823]: info: CoreCommandRouter::initPlayerControls Apr 24 05:12:59 volumio systemd[1]: Started Logitech Media Server Daemon. Apr 24 05:12:59 volumio systemd[1315]: Failed at step EXEC spawning /usr/sbin/squeezeboxserver: No such file or directory Apr 24 05:12:59 volumio systemd[1]: logitechmediaserver.service: main process exited, code=exited, status=203/EXEC Apr 24 05:12:59 volumio systemd[1]: Unit logitechmediaserver.service entered failed state. Apr 24 05:12:59 volumio sudo[1304]: pam_unix(sudo:session): session closed for user root Apr 24 05:12:59 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 05:12:59 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Apr 24 05:12:59 volumio systemd[1]: Reloading. Apr 24 05:12:59 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 05:12:59 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 05:12:59 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 05:12:59 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 05:12:59 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 24 05:12:59 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 24 05:12:59 volumio volumio[823]: info: BOOT COMPLETED Apr 24 05:12:59 volumio volumio[823]: [Metrics] CommandRouter: 46s 857.67ms Apr 24 05:12:59 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 05:12:59 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Apr 24 05:12:59 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Apr 24 05:12:59 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Apr 24 05:12:59 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Apr 24 05:13:00 volumio volumio-remote-updater[561]: [2024-04-24 05:13:00] [connect] Successful connection Apr 24 05:13:00 volumio sudo[1306]: pam_unix(sudo:session): session closed for user root Apr 24 05:13:05 volumio kernel: eth0: Link auto-negotiation speed 1000M bps full duplex Apr 24 05:13:05 volumio dhcpcd[1079]: eth0: carrier acquired Apr 24 05:13:05 volumio dhcpcd[1079]: eth0: rebinding lease of 192.168.50.109 Apr 24 05:13:05 volumio ifplugd(eth0)[662]: Link beat detected. Apr 24 05:13:05 volumio volumio[823]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Apr 24 05:13:05 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Apr 24 05:13:05 volumio volumio[823]: info: CoreCommandRouter::Close All Modals sent Apr 24 05:13:05 volumio volumio[823]: Express server listening on port 3000 Apr 24 05:13:05 volumio volumio[823]: [Metrics] WebUI: 56s 619.79ms Apr 24 05:13:05 volumio volumio[823]: info: Setting Device type: x86 Apr 24 05:13:05 volumio volumio[823]: Volumio Calling Home Apr 24 05:13:05 volumio dhcpcd[1079]: eth0: NAK: from 192.168.1.1 Apr 24 05:13:05 volumio dhcpcd[1079]: eth0: soliciting a DHCP lease Apr 24 05:13:05 volumio volumio[823]: info: Starting minidlna.service Apr 24 05:13:05 volumio volumio[823]: info: CoreStateMachine::resetVolumioState Apr 24 05:13:05 volumio volumio[823]: info: CoreStateMachine::getcurrentVolume Apr 24 05:13:05 volumio volumio[823]: info: CoreCommandRouter::volumioRetrievevolume Apr 24 05:13:05 volumio sudo[1356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Apr 24 05:13:05 volumio volumio[823]: info: CoreStateMachine::pushState Apr 24 05:13:05 volumio sudo[1356]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 05:13:05 volumio dhcpcd[1079]: eth0: offered 192.168.1.10 from 192.168.1.1 Apr 24 05:13:05 volumio volumio[823]: info: CorePlayQueue::getTrack 0 Apr 24 05:13:05 volumio volumio[823]: info: CoreCommandRouter::volumioPushState Apr 24 05:13:05 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 05:13:05 volumio systemd[1]: Starting MiniDLNA UPnP-A/V and DLNA media server... Apr 24 05:13:05 volumio systemd[1358]: Failed at step EXEC spawning /usr/bin/minidlnad: No such file or directory Apr 24 05:13:05 volumio dhcpcd[1079]: eth0: leased 192.168.1.10 for 86400 seconds Apr 24 05:13:05 volumio dhcpcd[1079]: eth0: adding host route to 192.168.1.10 via 127.0.0.1 Apr 24 05:13:05 volumio dhcpcd[1079]: eth0: adding route to 192.168.1.0/24 Apr 24 05:13:05 volumio dhcpcd[1079]: eth0: adding default route via 192.168.1.1 Apr 24 05:13:05 volumio avahi-daemon[614]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.10. Apr 24 05:13:05 volumio avahi-daemon[614]: New relevant interface eth0.IPv4 for mDNS. Apr 24 05:13:05 volumio avahi-daemon[614]: Registering new address record for 192.168.1.10 on eth0.IPv4. Apr 24 05:13:05 volumio systemd[1]: minidlna.service: control process exited, code=exited status=203 Apr 24 05:13:05 volumio systemd[1]: Failed to start MiniDLNA UPnP-A/V and DLNA media server. Apr 24 05:13:05 volumio systemd[1]: Unit minidlna.service entered failed state. Apr 24 05:13:06 volumio sudo[1356]: pam_unix(sudo:session): session closed for user root Apr 24 05:13:06 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 24 05:13:06 volumio volumio[823]: Unhandled rejection Error: No sockets available, cannot start. Apr 24 05:13:06 volumio volumio[823]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Apr 24 05:13:06 volumio volumio[823]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Apr 24 05:13:06 volumio volumio[823]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Apr 24 05:13:06 volumio volumio[823]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Apr 24 05:13:06 volumio volumio[823]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Apr 24 05:13:06 volumio volumio[823]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Apr 24 05:13:06 volumio volumio[823]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Apr 24 05:13:06 volumio volumio[823]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Apr 24 05:13:06 volumio volumio[823]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Apr 24 05:13:06 volumio volumio[823]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:282:30) Apr 24 05:13:06 volumio volumio[823]: at HashMap. (/volumio/app/pluginmanager.js:377:31) Apr 24 05:13:06 volumio volumio[823]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Apr 24 05:13:06 volumio volumio[823]: at HashMap.proto.(anonymous function) [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Apr 24 05:13:06 volumio volumio[823]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:376:20) Apr 24 05:13:06 volumio volumio[823]: at PluginManager.startPlugins (/volumio/app/pluginmanager.js:95:8) Apr 24 05:13:06 volumio volumio[823]: at new CoreCommandRouter (/volumio/app/index.js:45:22) Apr 24 05:13:06 volumio sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 24 05:13:06 volumio sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 05:13:06 volumio sudo[1387]: pam_unix(sudo:session): session closed for user root Apr 24 05:13:06 volumio sudo[1389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 24 05:13:06 volumio sudo[1389]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 24 05:13:06 volumio sudo[1389]: pam_unix(sudo:session): session closed for user root Apr 24 05:13:06 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 24 05:13:06 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 24 05:13:06 volumio volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 24 05:13:06 volumio volumio[823]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 24 05:13:06 volumio volumio[823]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 05:13:06 volumio volumio[823]: ReferenceError: deferred is not defined Apr 24 05:13:06 volumio volumio[823]: at ClientRequest.req.on (/data/plugins/music_service/youtube2/lib/core/gapi/auth.js:155:13) Apr 24 05:13:06 volumio volumio[823]: at emitOne (events.js:116:13) Apr 24 05:13:06 volumio volumio[823]: at ClientRequest.emit (events.js:211:7) Apr 24 05:13:06 volumio volumio[823]: at TLSSocket.socketErrorListener (_http_client.js:387:9) Apr 24 05:13:06 volumio volumio[823]: at emitOne (events.js:116:13) Apr 24 05:13:06 volumio volumio[823]: at TLSSocket.emit (events.js:211:7) Apr 24 05:13:06 volumio volumio[823]: at emitErrorNT (internal/streams/destroy.js:64:8) Apr 24 05:13:06 volumio volumio[823]: at _combinedTickCallback (internal/process/next_tick.js:138:11) Apr 24 05:13:06 volumio volumio[823]: at process._tickCallback (internal/process/next_tick.js:180:9) Apr 24 05:13:06 volumio volumio[823]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 05:13:07 volumio ntpd[711]: Listen normally on 4 eth0 192.168.1.10 UDP 123 Apr 24 05:13:07 volumio ntpd[711]: peers refreshed Apr 24 05:13:07 volumio sudo[1406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-24 05:12 Apr 24 05:13:07 volumio sudo[1406]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"