-- Logs begin at Thu 2019-02-14 02:11:59 PST, end at Mon 2025-01-13 20:58:07 PST. -- Jan 13 20:57:00 vol dhcpcd[868]: eth0: probing for an IPv4LL address Jan 13 20:57:00 vol wireless.js[567]: trying... Jan 13 20:57:00 vol sudo[914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 13 20:57:00 vol sudo[914]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:00 vol sudo[914]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:01 vol volumio-remote-updater[558]: [2025-01-13 20:57:01] [info] asio async_connect error: system:111 (Connection refused) Jan 13 20:57:01 vol volumio-remote-updater[558]: [2025-01-13 20:57:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 13 20:57:01 vol volumio-remote-updater[558]: [2025-01-13 20:57:01] [error] handle_connect error: Underlying Transport Error Jan 13 20:57:01 vol wireless.js[567]: trying... Jan 13 20:57:01 vol wpa_supplicant[881]: wlan0: Trying to associate with SSID 'pewpewlaserwu' Jan 13 20:57:01 vol sudo[917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 13 20:57:01 vol sudo[917]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:01 vol sudo[917]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:02 vol dhcpcd[868]: wlan0: carrier acquired Jan 13 20:57:02 vol dhcpcd[868]: wlan0: connected to Access Point `pewpewlaserwu' Jan 13 20:57:02 vol wpa_supplicant[881]: wlan0: Associated with 1e:5f:67:76:8b:79 Jan 13 20:57:02 vol wpa_supplicant[881]: wlan0: CTRL-EVENT-CONNECTED - Connection to 1e:5f:67:76:8b:79 completed [id=0 id_str=] Jan 13 20:57:02 vol wpa_supplicant[881]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jan 13 20:57:02 vol wpa_supplicant[881]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jan 13 20:57:02 vol dhcpcd[868]: wlan0: IAID 32:93:b3:21 Jan 13 20:57:02 vol dhcpcd[868]: wlan0: adding address fe80::dea6:32ff:fe93:b321 Jan 13 20:57:02 vol dhcpcd[868]: ipv6_addaddr1: Permission denied Jan 13 20:57:02 vol dhcpcd[868]: wlan0: carrier lost Jan 13 20:57:02 vol dhcpcd[868]: wlan0: carrier acquired Jan 13 20:57:02 vol dhcpcd[868]: wlan0: IAID 32:93:b3:21 Jan 13 20:57:02 vol dhcpcd[868]: wlan0: rebinding lease of 192.168.1.194 Jan 13 20:57:02 vol dhcpcd[868]: wlan0: soliciting an IPv6 router Jan 13 20:57:02 vol wireless.js[567]: trying... Jan 13 20:57:02 vol sudo[936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 13 20:57:02 vol sudo[936]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:02 vol sudo[936]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:02 vol wpa_supplicant[881]: RRM: Ignoring radio measurement request: Not RRM network Jan 13 20:57:03 vol dhcpcd[868]: wlan0: probing address 192.168.1.194/24 Jan 13 20:57:03 vol sh[519]: eth0: using IPv4LL address 169.254.167.202 Jan 13 20:57:03 vol dhcpcd[552]: eth0: using IPv4LL address 169.254.167.202 Jan 13 20:57:03 vol sh[519]: eth0: adding route to 169.254.0.0/16 Jan 13 20:57:03 vol sh[519]: eth0: adding default route Jan 13 20:57:03 vol dhcpcd[552]: eth0: adding route to 169.254.0.0/16 Jan 13 20:57:03 vol dhcpcd[552]: eth0: adding default route Jan 13 20:57:03 vol avahi-daemon[571]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.167.202. Jan 13 20:57:03 vol avahi-daemon[571]: New relevant interface eth0.IPv4 for mDNS. Jan 13 20:57:03 vol avahi-daemon[571]: Registering new address record for 169.254.167.202 on eth0.IPv4. Jan 13 20:57:03 vol sh[519]: forked to background, child pid 949 Jan 13 20:57:03 vol dhcpcd[552]: forked to background, child pid 949 Jan 13 20:57:03 vol ifplugd(eth0)[789]: client: ifup: interface eth0 already configured Jan 13 20:57:03 vol sh[519]: eth0=eth0 Jan 13 20:57:03 vol ifplugd(eth0)[789]: Program executed successfully. Jan 13 20:57:03 vol dhcpcd[949]: eth0: offered 192.168.1.193 from 192.168.1.1 Jan 13 20:57:03 vol dhcpcd[949]: eth0: probing address 192.168.1.193/24 Jan 13 20:57:03 vol wireless.js[567]: trying... Jan 13 20:57:03 vol sudo[976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 13 20:57:03 vol sudo[976]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:03 vol sudo[976]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:03 vol volumio-time-update[569]: volumio-time-update-util: Fetching time from Volumio... Jan 13 20:57:04 vol ntpd[768]: Listen normally on 3 eth0 169.254.167.202:123 Jan 13 20:57:04 vol ntpd[768]: new interface(s) found: waking up resolver Jan 13 20:57:04 vol wireless.js[567]: trying... Jan 13 20:57:04 vol sudo[983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 13 20:57:04 vol sudo[983]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:04 vol sudo[983]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:05 vol dhcpcd[868]: eth0: using IPv4LL address 169.254.167.202 Jan 13 20:57:05 vol dhcpcd[868]: eth0: adding route to 169.254.0.0/16 Jan 13 20:57:05 vol dhcpcd[868]: eth0: adding default route Jan 13 20:57:05 vol dhcpcd[868]: forked to background, child pid 997 Jan 13 20:57:05 vol sudo[867]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:05 vol nmbd[761]: [2025/01/13 20:57:05.418103, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 13 20:57:05 vol systemd[1]: Started Samba NMB Daemon. Jan 13 20:57:05 vol nmbd[761]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jan 13 20:57:05 vol systemd[1]: Starting Samba Winbind Daemon... Jan 13 20:57:05 vol winbindd[998]: [2025/01/13 20:57:05.674821, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jan 13 20:57:05 vol winbindd[998]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jan 13 20:57:05 vol winbindd[998]: [2025/01/13 20:57:05.699283, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 13 20:57:05 vol winbindd[998]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jan 13 20:57:05 vol systemd[1]: Started Samba Winbind Daemon. Jan 13 20:57:05 vol systemd[1]: Starting Samba SMB Daemon... Jan 13 20:57:05 vol wireless.js[567]: trying... Jan 13 20:57:05 vol sudo[1005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 13 20:57:05 vol sudo[1005]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:05 vol sudo[1005]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:06 vol smbd[1003]: [2025/01/13 20:57:06.097085, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 13 20:57:06 vol smbd[1003]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jan 13 20:57:06 vol systemd[1]: Started Samba SMB Daemon. Jan 13 20:57:06 vol wireless.js[567]: trying... Jan 13 20:57:06 vol sudo[1015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 13 20:57:06 vol sudo[1015]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:06 vol sudo[1015]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:07 vol wireless.js[567]: trying... Jan 13 20:57:07 vol sudo[1018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 13 20:57:07 vol sudo[1018]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:07 vol sudo[1018]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:08 vol dhcpcd[997]: wlan0: leased 192.168.1.194 for 86400 seconds Jan 13 20:57:08 vol avahi-daemon[571]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.194. Jan 13 20:57:08 vol avahi-daemon[571]: New relevant interface wlan0.IPv4 for mDNS. Jan 13 20:57:08 vol dhcpcd[997]: wlan0: adding route to 192.168.1.0/24 Jan 13 20:57:08 vol dhcpcd[997]: wlan0: adding default route via 192.168.1.1 Jan 13 20:57:08 vol avahi-daemon[571]: Registering new address record for 192.168.1.194 on wlan0.IPv4. Jan 13 20:57:08 vol dhcpcd[997]: eth0: deleting default route Jan 13 20:57:08 vol dhcpcd[949]: eth0: pid 997 deleted default route Jan 13 20:57:08 vol dhcpcd[949]: eth0: leased 192.168.1.193 for 86400 seconds Jan 13 20:57:08 vol avahi-daemon[571]: Registering new address record for 192.168.1.193 on eth0.IPv4. Jan 13 20:57:08 vol dhcpcd[949]: eth0: adding route to 192.168.1.0/24 Jan 13 20:57:08 vol dhcpcd[949]: eth0: adding default route via 192.168.1.1 Jan 13 20:57:08 vol avahi-daemon[571]: Withdrawing address record for 169.254.167.202 on eth0. Jan 13 20:57:08 vol dhcpcd[997]: eth0: pid 949 deleted IP address 169.254.167.202/16 Jan 13 20:57:08 vol dhcpcd[949]: eth0: deleting route to 169.254.0.0/16 Jan 13 20:57:08 vol avahi-daemon[571]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.167.202. Jan 13 20:57:08 vol dhcpcd[997]: eth0: deleting route to 169.254.0.0/16 Jan 13 20:57:08 vol avahi-daemon[571]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.193. Jan 13 20:57:08 vol dhcpcd[997]: eth0: probing for an IPv4LL address Jan 13 20:57:08 vol wireless.js[567]: trying... Jan 13 20:57:08 vol sudo[1097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 13 20:57:08 vol sudo[1097]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:08 vol sudo[1097]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:08 vol wireless.js[567]: Connected to: ----pewpewlaserwu Jan 13 20:57:08 vol wireless.js[567]: ---- Jan 13 20:57:08 vol sudo[1100]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 13 20:57:08 vol sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:08 vol sudo[1100]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:08 vol wireless.js[567]: ... joined AP, wlan0 IPv4 is 192.168.1.194, ipV6 is undefined Jan 13 20:57:08 vol wireless.js[567]: It's done! AP Jan 13 20:57:08 vol kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 13 20:57:08 vol systemd[1]: Started Wireless Services. Jan 13 20:57:08 vol systemd[1]: Started Volumio Backend Module. Jan 13 20:57:08 vol systemd[1]: Started Volumio Cpu Tweaker. Jan 13 20:57:09 vol volumio-cpu-tweak[1106]: Setting RT Priority for mpd Jan 13 20:57:09 vol volumio-cpu-tweak[1106]: Setting MPD Affinity Jan 13 20:57:09 vol volumio-cpu-tweak[1106]: pid 780's current affinity mask: f Jan 13 20:57:09 vol volumio-cpu-tweak[1106]: pid 780's new affinity mask: 3 Jan 13 20:57:09 vol volumio-cpu-tweak[1106]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jan 13 20:57:09 vol volumio-cpu-tweak[1106]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jan 13 20:57:09 vol systemd[1]: volumio_cpu_tweak.service: Succeeded. Jan 13 20:57:09 vol volumio-time-update[569]: volumio-time-update-util: Setting system time to: 2025-01-13 20:57:39 Jan 13 20:57:09 vol sudo[1123]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-01-13 20:57:39 Jan 13 20:57:09 vol sudo[1123]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:09 vol dbus-daemon[573]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.10' (uid=0 pid=1124 comm="timedatectl set-time 2025-01-13 20:57:39 ") Jan 13 20:57:09 vol nmbd[761]: [2025/01/13 20:57:09.438928, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 13 20:57:09 vol nmbd[761]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Jan 13 20:57:09 vol systemd[1]: Starting Time & Date Service... Jan 13 20:57:09 vol nmbd[761]: [2025/01/13 20:57:09.439093, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Jan 13 20:57:09 vol nmbd[761]: retransmit_or_expire_response_records: Failed to resend packet id 15852 to IP 169.254.255.255 on subnet 169.254.167.202 Jan 13 20:57:09 vol nmbd[761]: [2025/01/13 20:57:09.439154, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 13 20:57:09 vol nmbd[761]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Jan 13 20:57:09 vol nmbd[761]: [2025/01/13 20:57:09.439218, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Jan 13 20:57:09 vol nmbd[761]: retransmit_or_expire_response_records: Failed to resend packet id 15853 to IP 169.254.255.255 on subnet 169.254.167.202 Jan 13 20:57:09 vol nmbd[761]: [2025/01/13 20:57:09.439274, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 13 20:57:09 vol nmbd[761]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Jan 13 20:57:09 vol nmbd[761]: [2025/01/13 20:57:09.439328, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Jan 13 20:57:09 vol nmbd[761]: retransmit_or_expire_response_records: Failed to resend packet id 15854 to IP 169.254.255.255 on subnet 169.254.167.202 Jan 13 20:57:09 vol nmbd[761]: [2025/01/13 20:57:09.439383, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 13 20:57:09 vol nmbd[761]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Jan 13 20:57:09 vol nmbd[761]: [2025/01/13 20:57:09.439438, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Jan 13 20:57:09 vol nmbd[761]: retransmit_or_expire_response_records: Failed to resend packet id 15855 to IP 169.254.255.255 on subnet 169.254.167.202 Jan 13 20:57:09 vol nmbd[761]: [2025/01/13 20:57:09.439489, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 13 20:57:09 vol nmbd[761]: Packet send failed to 169.254.255.255(137) ERRNO=Network is unreachable Jan 13 20:57:09 vol nmbd[761]: [2025/01/13 20:57:09.439539, 0] ../source3/nmbd/nmbd_packets.c:1639(retransmit_or_expire_response_records) Jan 13 20:57:09 vol nmbd[761]: retransmit_or_expire_response_records: Failed to resend packet id 15856 to IP 169.254.255.255 on subnet 169.254.167.202 Jan 13 20:57:09 vol ntpd[768]: Listen normally on 4 eth0 192.168.1.193:123 Jan 13 20:57:09 vol ntpd[768]: Listen normally on 5 wlan0 192.168.1.194:123 Jan 13 20:57:09 vol ntpd[768]: Deleting interface #3 eth0, 169.254.167.202#123, interface stats: received=0, sent=0, dropped=0, active_time=5 secs Jan 13 20:57:09 vol ntpd[768]: new interface(s) found: waking up resolver Jan 13 20:57:09 vol dbus-daemon[573]: [system] Successfully activated service 'org.freedesktop.timedate1' Jan 13 20:57:09 vol systemd[1]: Started Time & Date Service. Jan 13 20:57:39 vol systemd-timedated[1125]: Changed local time to Mon Jan 13 20:57:39 2025 Jan 13 20:57:39 vol sudo[1123]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:39 vol volumio-time-update[569]: volumio-time-update-util: System time updated successfully. Jan 13 20:57:39 vol systemd[1]: Started Volumio Time Update Utility. Jan 13 20:57:39 vol systemd[1]: Reached target Multi-User System. Jan 13 20:57:39 vol systemd[1]: Reached target Graphical Interface. Jan 13 20:57:39 vol systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 13 20:57:39 vol systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 13 20:57:39 vol systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 13 20:57:39 vol systemd[1]: Startup finished in 12.105s (kernel) + 24.801s (userspace) = 36.906s. Jan 13 20:57:39 vol nmbd[761]: [2025/01/13 20:57:39.837383, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 13 20:57:39 vol nmbd[761]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Jan 13 20:57:40 vol volumio[1105]: info: ------------------------------------------- Jan 13 20:57:40 vol volumio[1105]: info: ----- Volumio3 ---- Jan 13 20:57:40 vol volumio[1105]: info: ------------------------------------------- Jan 13 20:57:40 vol volumio[1105]: info: ----- System startup ---- Jan 13 20:57:40 vol volumio[1105]: info: ------------------------------------------- Jan 13 20:57:40 vol volumio-remote-updater[558]: [2025-01-13 20:57:40] [connect] Successful connection Jan 13 20:57:40 vol volumio[1105]: info: MYVOLUMIO Environment detected Jan 13 20:57:40 vol volumio[1105]: info: Plugin folders cleanup Jan 13 20:57:40 vol volumio[1105]: info: Scanning into folder /volumio/app/plugins/ Jan 13 20:57:40 vol volumio[1105]: info: Scanning category audio_interface Jan 13 20:57:40 vol volumio[1105]: info: Scanning category miscellanea Jan 13 20:57:40 vol volumio[1105]: info: Scanning category music_service Jan 13 20:57:40 vol volumio[1105]: info: Scanning category plugins.json Jan 13 20:57:40 vol volumio[1105]: info: Scanning category system_controller Jan 13 20:57:40 vol volumio[1105]: info: Scanning category user_interface Jan 13 20:57:40 vol volumio[1105]: info: Scanning into folder /data/plugins/ Jan 13 20:57:40 vol volumio[1105]: info: Scanning category miscellanea Jan 13 20:57:40 vol volumio[1105]: info: Scanning category music_service Jan 13 20:57:40 vol volumio[1105]: info: Scanning category system_controller Jan 13 20:57:40 vol volumio[1105]: info: Scanning category system_hardware Jan 13 20:57:40 vol volumio[1105]: info: Scanning category user_interface Jan 13 20:57:40 vol volumio[1105]: info: Plugin folders cleanup completed Jan 13 20:57:40 vol volumio[1105]: info: ------------------------------------------- Jan 13 20:57:40 vol volumio[1105]: info: ----- Core plugins startup ---- Jan 13 20:57:40 vol volumio[1105]: info: ------------------------------------------- Jan 13 20:57:40 vol volumio[1105]: info: Loading plugins from folder /volumio/app/plugins/ Jan 13 20:57:40 vol volumio[1105]: info: Adding plugin upnp to MyMusic Plugins Jan 13 20:57:40 vol volumio[1105]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 13 20:57:40 vol volumio[1105]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 13 20:57:40 vol volumio[1105]: info: Loading plugins from folder /data/plugins/ Jan 13 20:57:40 vol volumio[1105]: info: Loading plugin "system"... Jan 13 20:57:41 vol volumio[1105]: info: Loading plugin "appearance"... Jan 13 20:57:41 vol volumio[1105]: info: Loading plugin "network"... Jan 13 20:57:41 vol volumio[1105]: info: Refreshing Cached IP Addresses Jan 13 20:57:41 vol sudo[1144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 13 20:57:41 vol sudo[1144]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:41 vol sudo[1144]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:42 vol sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 13 20:57:42 vol sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:42 vol sudo[1146]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:42 vol volumio[1105]: info: Loading plugin "peppy_screensaver"... Jan 13 20:57:42 vol sudo[1155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 13 20:57:42 vol sudo[1155]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:42 vol dhcpcd[997]: eth0: using IPv4LL address 169.254.94.218 Jan 13 20:57:42 vol dhcpcd[997]: eth0: adding route to 169.254.0.0/16 Jan 13 20:57:42 vol avahi-daemon[571]: Registering new address record for 169.254.94.218 on eth0.IPv4. Jan 13 20:57:42 vol volumio[1105]: info: Applying required configuration parameters for plugin peppy_screensaver Jan 13 20:57:42 vol volumio[1105]: info: Loading plugin "services"... Jan 13 20:57:42 vol volumio[1105]: info: Loading plugin "alsa_controller"... Jan 13 20:57:42 vol volumio[1105]: warn: Unable to locate the audio output device Fosi Audio ZD3. Please configure a valid output device. Jan 13 20:57:42 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 13 20:57:42 vol volumio[1105]: info: Loading plugin "wizard"... Jan 13 20:57:42 vol volumio[1105]: info: Loading plugin "networkfs"... Jan 13 20:57:42 vol volumio[1105]: info: Starting Udev Watcher for removable devices Jan 13 20:57:42 vol sudo[1191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=xbox,password=xbox,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.21/Music /mnt/NAS/Music Jan 13 20:57:42 vol sudo[1191]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:42 vol sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.21:/Music /mnt/NAS/Music Jan 13 20:57:42 vol sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:42 vol volumio[1105]: info: Ignoring mount for partition: boot Jan 13 20:57:42 vol volumio[1105]: info: Ignoring mount for partition: volumio Jan 13 20:57:42 vol volumio[1105]: info: Ignoring mount for partition: volumio_data Jan 13 20:57:42 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 13 20:57:42 vol volumio[1105]: info: Loading plugin "volumio_command_line_client"... Jan 13 20:57:42 vol volumio[1105]: info: Plugin upnp is not enabled Jan 13 20:57:42 vol volumio[1105]: info: Loading plugin "my_music"... Jan 13 20:57:42 vol volumio[1105]: info: Loading plugin "mpd"... Jan 13 20:57:42 vol kernel: Key type cifs.spnego registered Jan 13 20:57:42 vol kernel: Key type cifs.idmap registered Jan 13 20:57:42 vol kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Jan 13 20:57:42 vol kernel: CIFS: Attempting to mount //192.168.1.21/Music Jan 13 20:57:42 vol systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. Jan 13 20:57:42 vol kernel: cryptd: max_cpu_qlen set to 1000 Jan 13 20:57:43 vol systemd[1]: Starting Preprocess NFS configuration... Jan 13 20:57:43 vol systemd[1]: Reached target Host and Network Name Lookups. Jan 13 20:57:43 vol systemd[1]: nfs-config.service: Succeeded. Jan 13 20:57:43 vol systemd[1]: Started Preprocess NFS configuration. Jan 13 20:57:43 vol systemd[1]: Starting NFS status monitor for NFSv2/3 locking.... Jan 13 20:57:43 vol systemd[1]: Starting Notify NFS peers of a restart... Jan 13 20:57:43 vol sm-notify[1242]: Version 1.3.3 starting Jan 13 20:57:43 vol sudo[1191]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:43 vol systemd[1]: rpc-statd-notify.service: Succeeded. Jan 13 20:57:43 vol systemd[1]: Started Notify NFS peers of a restart. Jan 13 20:57:43 vol rpc.statd[1243]: Version 1.3.3 starting Jan 13 20:57:43 vol rpc.statd[1243]: Flags: TI-RPC Jan 13 20:57:43 vol rpc.statd[1243]: Failed to read /var/lib/nfs/state: Success Jan 13 20:57:43 vol rpc.statd[1243]: Initializing NSM state Jan 13 20:57:43 vol volumio[1105]: info: Plugin upnp_browser is not enabled Jan 13 20:57:43 vol volumio[1105]: info: Loading plugin "alarm-clock"... Jan 13 20:57:43 vol systemd[1]: Started NFS status monitor for NFSv2/3 locking.. Jan 13 20:57:43 vol sudo[1193]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:43 vol volumio[1105]: info: Plugin airplay_emulation is not enabled Jan 13 20:57:43 vol volumio[1105]: info: Loading plugin "last_100"... Jan 13 20:57:43 vol volumio[1105]: info: Loading plugin "webradio"... Jan 13 20:57:43 vol volumio[1105]: info: Loading plugin "i2s_dacs"... Jan 13 20:57:43 vol volumio[1105]: info: I2S DAC not set, start Auto-detection Jan 13 20:57:43 vol volumio[1105]: info: Loading plugin "volumiodiscovery"... Jan 13 20:57:43 vol volumio[1105]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 13 20:57:43 vol volumio[1105]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 13 20:57:43 vol volumio[1105]: *** WARNING *** For more information see Jan 13 20:57:43 vol node[1105]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 13 20:57:43 vol volumio[1105]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 13 20:57:43 vol volumio[1105]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 13 20:57:43 vol volumio[1105]: *** WARNING *** For more information see Jan 13 20:57:43 vol node[1105]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 13 20:57:43 vol node[1105]: *** WARNING *** For more information see Jan 13 20:57:43 vol node[1105]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 13 20:57:43 vol node[1105]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 13 20:57:43 vol node[1105]: *** WARNING *** For more information see Jan 13 20:57:43 vol volumio[1105]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 13 20:57:43 vol volumio[1105]: info: Discovery: Started advertising with name: Vol Jan 13 20:57:43 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 13 20:57:43 vol volumio[1105]: info: Plugin spop is not enabled Jan 13 20:57:43 vol volumio[1105]: info: Plugin ytmusic is not enabled Jan 13 20:57:43 vol volumio[1105]: info: Loading plugin "now_playing"... Jan 13 20:57:43 vol ntpd[768]: Listen normally on 6 eth0 169.254.94.218:123 Jan 13 20:57:43 vol ntpd[768]: new interface(s) found: waking up resolver Jan 13 20:57:44 vol volumio[1105]: info: Loading plugin "outputs"... Jan 13 20:57:44 vol volumio[1105]: info: Loading plugin "albumart"... Jan 13 20:57:44 vol volumio[1105]: info: Plugin example_plugin is not enabled Jan 13 20:57:44 vol volumio[1105]: info: Loading plugin "inputs"... Jan 13 20:57:44 vol volumio[1105]: info: Loading plugin "updater_comm"... Jan 13 20:57:45 vol volumio[1105]: info: Plugin mpdemulation is not enabled Jan 13 20:57:45 vol volumio[1105]: info: Loading plugin "rest_api"... Jan 13 20:57:45 vol volumio[1105]: info: Loading plugin "websocket"... Jan 13 20:57:45 vol volumio[1105]: info: Starting Socket.io Server version 2.3.0 Jan 13 20:57:45 vol volumio[1105]: info: Plugin backup_restore is not enabled Jan 13 20:57:45 vol volumio[1105]: info: Loading plugin "ir_controller"... Jan 13 20:57:45 vol volumio[1105]: Forking 3 albumart workers Jan 13 20:57:45 vol volumio[1105]: info: Applying required configuration parameters for plugin ir_controller Jan 13 20:57:45 vol volumio[1105]: info: Loading plugin "rotaryencoder2"... Jan 13 20:57:45 vol volumio[1105]: Starting albumart workers Jan 13 20:57:45 vol volumio[1105]: Starting albumart workers Jan 13 20:57:45 vol volumio[1105]: Starting albumart workers Jan 13 20:57:45 vol volumio[1105]: info: Plugin Systeminfo is not enabled Jan 13 20:57:45 vol volumio[1105]: info: Plugin peppymeterbasic is not enabled Jan 13 20:57:45 vol volumio[1105]: info: Plugin peppyspectrum is not enabled Jan 13 20:57:45 vol volumio[1105]: info: Plugin randomizer is not enabled Jan 13 20:57:45 vol volumio[1105]: info: Loading plugin "touch_display"... Jan 13 20:57:46 vol sudo[1155]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:46 vol volumio[1105]: info: Applying required configuration parameters for plugin touch_display Jan 13 20:57:46 vol volumio[1105]: info: Loading i18n strings for locale en Jan 13 20:57:46 vol volumio[1105]: Updating browse sources language Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::initPlayerControls Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 20:57:46 vol volumio[1105]: Express server listening on port 3000 Jan 13 20:57:46 vol volumio[1105]: [Metrics] WebUI: 7s 101.20ms Jan 13 20:57:46 vol volumio[1105]: info: CoreStateMachine::resetVolumioState Jan 13 20:57:46 vol volumio[1105]: info: CoreStateMachine::getcurrentVolume Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::volumioRetrievevolume Jan 13 20:57:46 vol volumio[1105]: info: CoreStateMachine::pushState Jan 13 20:57:46 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::volumioPushState Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 20:57:46 vol volumio[1105]: info: Volumio Network Manager: Network status updated: 3 Jan 13 20:57:46 vol volumio[1105]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds Jan 13 20:57:46 vol volumio[1105]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jan 13 20:57:46 vol volumio[1105]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jan 13 20:57:46 vol volumio[1105]: info: Setting Device type: Raspberry PI Jan 13 20:57:46 vol volumio[1105]: info: CoreStateMachine::setRepeat true single undefined Jan 13 20:57:46 vol volumio[1105]: info: CoreStateMachine::pushState Jan 13 20:57:46 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::volumioPushState Jan 13 20:57:46 vol volumio[1105]: info: CoreStateMachine::setRandom true Jan 13 20:57:46 vol volumio[1105]: info: CoreStateMachine::pushState Jan 13 20:57:46 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::volumioPushState Jan 13 20:57:46 vol volumio[1105]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jan 13 20:57:46 vol volumio[1105]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Jan 13 20:57:46 vol volumio[1105]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jan 13 20:57:46 vol volumio[1105]: info: Discovery: adding 46e28320-1cb8-4832-9745-1d9ed3e94f66 Jan 13 20:57:46 vol volumio[1105]: info: Discovery: Found device Vol Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:57:46 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:46 vol volumio[1105]: info: Discovery: this is already registered, 46e28320-1cb8-4832-9745-1d9ed3e94f66 Jan 13 20:57:46 vol volumio[1105]: info: Discovery: Found device Vol Jan 13 20:57:46 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:57:46 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:46 vol volumio[1105]: info: Completed loading Core Plugins Jan 13 20:57:46 vol volumio[1105]: info: Preparing to generate the ALSA configuration file Jan 13 20:57:46 vol volumio[1105]: info: Reloading queue from file Jan 13 20:57:46 vol volumio[1105]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Jan 13 20:57:46 vol volumio[1105]: info: Reading ALSA contributions from plugins. Jan 13 20:57:46 vol volumio[1105]: info: Asound.conf file unchanged, so no further update is needed Jan 13 20:57:47 vol volumio[1105]: info: Output device has changed, restarting MPD Jan 13 20:57:47 vol sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 13 20:57:47 vol volumio[1105]: info: ___________ START PLUGINS ___________ Jan 13 20:57:47 vol sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:47 vol sudo[1309]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:47 vol volumio[1105]: info: Loading i18n strings for locale en Jan 13 20:57:47 vol sudo[1311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 13 20:57:47 vol sudo[1311]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:47 vol volumio[1105]: info: /tmp/myfifo created Jan 13 20:57:47 vol systemd[1]: Stopping Music Player Daemon... Jan 13 20:57:47 vol sudo[1317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 Jan 13 20:57:47 vol sudo[1317]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:47 vol sudo[1317]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:47 vol volumio[1105]: info: snd-dummy loaded Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 13 20:57:47 vol volumio[1105]: info: ControllerMpd::onStart: Initializing MPD Jan 13 20:57:47 vol volumio[1105]: info: Creating MPD Configuration file Jan 13 20:57:47 vol systemd[1]: systemd-fsckd.service: Succeeded. Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 13 20:57:47 vol volumio[1105]: info: [1736830667203] CoreMusicLibrary::Adding element Last_100 Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 20:57:47 vol sudo[1329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 13 20:57:47 vol volumio[1105]: info: [1736830667220] CoreMusicLibrary::Adding element Webradio Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 20:57:47 vol sudo[1329]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 13 20:57:47 vol sudo[1328]: 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 Jan 13 20:57:47 vol sudo[1328]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:47 vol sudo[1329]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:47 vol volumio[1105]: info: Initializing BBC Radios Jan 13 20:57:47 vol sudo[1331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 13 20:57:47 vol sudo[1331]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:47 vol sudo[1328]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:47 vol systemd[1]: mpd.service: Succeeded. Jan 13 20:57:47 vol systemd[1]: Stopped Music Player Daemon. Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: [now-playing] ConfigUpdater: config is up to date. Jan 13 20:57:47 vol volumio[1105]: info: Loading i18n strings for locale en Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 13 20:57:47 vol volumio[1105]: info: Loading i18n strings for locale en Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 13 20:57:47 vol systemd[1]: Starting Music Player Daemon... Jan 13 20:57:47 vol volumio[1105]: info: Volumio Calling Home Jan 13 20:57:47 vol systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 13 20:57:47 vol systemd[1]: mpd.service: Succeeded. Jan 13 20:57:47 vol systemd[1]: Stopped Music Player Daemon. Jan 13 20:57:47 vol systemd[1]: Starting Music Player Daemon... Jan 13 20:57:47 vol volumio[1105]: info: Preparing to generate the ALSA configuration file Jan 13 20:57:47 vol sudo[1347]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 13 20:57:47 vol sudo[1347]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:47 vol sudo[1347]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:47 vol sudo[1355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc Jan 13 20:57:47 vol sudo[1355]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:47 vol sudo[1355]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:47 vol sudo[1357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=7 pin_b=8 relative_axis=true steps-per-period=2 Jan 13 20:57:47 vol sudo[1357]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:47 vol sudo[1361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Jan 13 20:57:47 vol sudo[1361]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:47 vol sudo[1363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Jan 13 20:57:47 vol sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:47 vol kernel: rotary-encoder rotary@7: gray Jan 13 20:57:47 vol kernel: input: rotary@7 as /devices/platform/rotary@7/input/input4 Jan 13 20:57:47 vol systemd[1]: Reloading. Jan 13 20:57:47 vol sudo[1357]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:47 vol sudo[1368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jan 13 20:57:47 vol sudo[1368]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:47 vol volumio[1105]: info: [now-playing] Fetching API key... Jan 13 20:57:47 vol volumio[1105]: info: [now-playing] App is listening on port 4004. Jan 13 20:57:47 vol volumio[1105]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Jan 13 20:57:47 vol volumio[1105]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Jan 13 20:57:47 vol volumio[1105]: info: Reading ALSA contributions from plugins. Jan 13 20:57:47 vol volumio[1105]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:57:47 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:47 vol volumio[1105]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Jan 13 20:57:47 vol volumio[1105]: info: MPD Permissions set Jan 13 20:57:47 vol volumio[1105]: info: MPD Permissions set Jan 13 20:57:47 vol volumio[1105]: info: Volumio called home Jan 13 20:57:47 vol volumio[1105]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jan 13 20:57:47 vol volumio[1105]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol systemd-udevd[1319]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 20:57:47 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:47 vol systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jan 13 20:57:48 vol volumio[1105]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Jan 13 20:57:48 vol sudo[1402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Jan 13 20:57:48 vol sudo[1402]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:48 vol volumio[1105]: info: ir_controller: LIRC correctly updated. Jan 13 20:57:48 vol volumio[1105]: info: ir_controller: HAT did not load /proc/device-tree/ir_receiver! Jan 13 20:57:48 vol sudo[1402]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:48 vol volumio[1105]: info: Asound.conf file unchanged, so no further update is needed Jan 13 20:57:48 vol volumio[1105]: info: Output device has changed, restarting MPD Jan 13 20:57:48 vol sudo[1407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 13 20:57:48 vol sudo[1407]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:48 vol sudo[1407]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:48 vol sudo[1409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 13 20:57:48 vol sudo[1409]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:48 vol volumio[1105]: info: ir_controller: Raspberry Pi revision code: c03112 Jan 13 20:57:48 vol volumio[1105]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Jan 13 20:57:48 vol volumio[1105]: info: MPD Permissions set Jan 13 20:57:48 vol systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:48 vol sudo[1415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r -1 Jan 13 20:57:48 vol sudo[1415]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:48 vol sudo[1415]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:48 vol sudo[1426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-ir gpio_pin=25 gpio_pull=down invert=1 Jan 13 20:57:48 vol sudo[1426]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:48 vol sudo[1426]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:48 vol kernel: Registered IR keymap rc-rc6-mce Jan 13 20:57:48 vol kernel: IR RC6 protocol handler initialized Jan 13 20:57:48 vol volumio[1105]: info: ir_controller: Overlay gpio-ir gpio_pin=25 gpio_pull=down invert=1 loaded. Jan 13 20:57:48 vol mpd[1353]: Jan 13 20:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 13 20:57:48 vol sudo[1363]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:48 vol volumio[1105]: info: touch_display: systemctl disable getty@tty1.service succeeded. Jan 13 20:57:48 vol sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Jan 13 20:57:48 vol sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:48 vol kernel: rc rc0: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0 Jan 13 20:57:48 vol kernel: rc rc0: lirc_dev: driver gpio_ir_recv registered at minor = 0, raw IR receiver, no transmitter Jan 13 20:57:48 vol kernel: input: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0/input5 Jan 13 20:57:48 vol sudo[1361]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:48 vol volumio[1105]: info: touch_display: systemctl stop getty@tty1.service succeeded. Jan 13 20:57:48 vol systemd[1]: Reloading. Jan 13 20:57:48 vol sudo[1457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 13 20:57:48 vol sudo[1457]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:48 vol sudo[1457]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:48 vol sudo[1459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 13 20:57:48 vol sudo[1459]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:48 vol systemd-udevd[1319]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 13 20:57:48 vol systemd-logind[578]: Watching system buttons on /dev/input/event2 (gpio_ir_recv) Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 20:57:48 vol sudo[1459]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:48 vol volumio[1105]: verbose: New Socket.io Connection to 192.168.1.193 from 192.168.1.2 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jan 13 20:57:48 vol systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::volumioGetVisibleSources Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:57:48 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::volumioGetQueue Jan 13 20:57:48 vol volumio[1105]: info: CoreStateMachine::getQueue Jan 13 20:57:48 vol volumio[1105]: info: CorePlayQueue::getQueue Jan 13 20:57:48 vol volumio[1105]: info: Listing playlists Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 13 20:57:48 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 13 20:57:48 vol systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. Jan 13 20:57:48 vol sudo[1464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=6 pin_b=5 relative_axis=true steps-per-period=2 Jan 13 20:57:48 vol kernel: rotary-encoder rotary@6: gray Jan 13 20:57:48 vol kernel: input: rotary@6 as /devices/platform/rotary@6/input/input6 Jan 13 20:57:48 vol sudo[1464]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:48 vol sudo[1464]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:49 vol sudo[1368]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:49 vol volumio[1105]: info: touch_display: systemctl daemon-reload succeeded. Jan 13 20:57:49 vol systemd[1]: Starting lircd(8) initialization helper tool... Jan 13 20:57:49 vol systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 13 20:57:49 vol systemd[1]: mpd.service: Succeeded. Jan 13 20:57:49 vol systemd[1]: Stopped Music Player Daemon. Jan 13 20:57:49 vol systemd[1]: Starting Music Player Daemon... Jan 13 20:57:49 vol sudo[1477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Jan 13 20:57:49 vol sudo[1477]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:49 vol sudo[1482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Jan 13 20:57:49 vol sudo[1482]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:49 vol sudo[1478]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 13 20:57:49 vol sudo[1478]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:49 vol systemd-udevd[1319]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 13 20:57:49 vol sudo[1478]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:49 vol systemd[1]: Started Volumio Kiosk. Jan 13 20:57:49 vol sudo[1477]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:49 vol volumio[1105]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Jan 13 20:57:49 vol volumio[1105]: info: touch_display: Volumio Kiosk started. Jan 13 20:57:49 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:57:49 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:49 vol systemd[1]: systemd-hostnamed.service: Succeeded. Jan 13 20:57:49 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:57:49 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:49 vol volumio[1105]: info: touch_display: X display number found: Jan 13 20:57:49 vol volumio[1105]: info: touch_display: X display number found: 0 Jan 13 20:57:49 vol startx[1484]: X.Org X Server 1.20.4 Jan 13 20:57:49 vol startx[1484]: X Protocol Version 11, Revision 0 Jan 13 20:57:49 vol startx[1484]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Jan 13 20:57:49 vol startx[1484]: Current Operating System: Linux vol 6.6.62-v7l+ #1816 SMP Mon Nov 18 15:33:33 GMT 2024 armv7l Jan 13 20:57:49 vol startx[1484]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=1600 bcm2708_fb.fbheight=720 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:93:B3:20 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=af3faec2-9654-4fec-8791-d5638a5837ad imgfile=/volumio_current.sqsh bootpart=UUID=2E0A-AE55 datapart=UUID=660717eb-e471-4727-aac1-2c263938c365 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Jan 13 20:57:49 vol startx[1484]: Build Date: 04 April 2023 07:50:56AM Jan 13 20:57:49 vol startx[1484]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Jan 13 20:57:49 vol startx[1484]: Current version of pixman: 0.36.0 Jan 13 20:57:49 vol startx[1484]: Before reporting problems, check http://wiki.x.org Jan 13 20:57:49 vol startx[1484]: to make sure that you have the latest version. Jan 13 20:57:49 vol startx[1484]: Markers: (--) probed, (**) from config file, (==) default setting, Jan 13 20:57:49 vol startx[1484]: (++) from command line, (!!) notice, (II) informational, Jan 13 20:57:49 vol startx[1484]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jan 13 20:57:49 vol startx[1484]: (==) Log file: "/var/log/Xorg.0.log", Time: Mon Jan 13 20:57:49 2025 Jan 13 20:57:49 vol startx[1484]: (==) Using config directory: "/etc/X11/xorg.conf.d" Jan 13 20:57:49 vol startx[1484]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jan 13 20:57:49 vol volumio[1105]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jan 13 20:57:49 vol lircd-setup[1475]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Jan 13 20:57:49 vol lircd-setup[1475]: parser = configparser.SafeConfigParser() Jan 13 20:57:49 vol volumio[1105]: info: touch_display: X display number found: 0 Jan 13 20:57:49 vol systemd[1]: lircd-setup.service: Succeeded. Jan 13 20:57:49 vol systemd[1]: Started lircd(8) initialization helper tool. Jan 13 20:57:49 vol systemd[1]: Starting Flexible IR remote input/output application support... Jan 13 20:57:49 vol lircd-0.10.1[1519]: Info: lircd: Opening log, level: Info Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Version: lircd 0.10.1 Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: System info: Linux vol 6.6.62-v7l+ #1816 SMP Mon Nov 18 15:33:33 GMT 2024 armv7l GNU/Linux Jan 13 20:57:49 vol lircd-0.10.1[1519]: Info: Initial device: /dev/lirc0 Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: 'lirc' written to protocols file /sys/class/rc/rc0/protocols Jan 13 20:57:49 vol lircd-0.10.1[1519]: Info: Initial device: /dev/lirc0 Jan 13 20:57:49 vol lircd-0.10.1[1519]: Info: [lirc] protocol is enabled Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: driver: default Jan 13 20:57:49 vol lircd[1519]: lircd-0.10.1[1519]: Info: lircd: Opening log, level: Info Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: output: /var/run/lirc/lircd Jan 13 20:57:49 vol lircd[1519]: lircd-0.10.1[1519]: Notice: Using systemd fd Jan 13 20:57:49 vol lircd[1519]: lircd-0.10.1[1519]: Warning: Running as root Jan 13 20:57:49 vol lircd[1519]: lircd-0.10.1[1519]: Info: Using remote: lircd.conf. Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: nodaemon: 1 Jan 13 20:57:49 vol lircd[1519]: lircd-0.10.1[1519]: Notice: lircd(default) ready, using /var/run/lirc/lircd Jan 13 20:57:49 vol systemd[1]: Started Flexible IR remote input/output application support. Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: logfile: syslog Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: immediate-init: 0 Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: permission: 666 Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: driver-options: Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: listen: 0 Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: connect: (null) Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: userelease: 0 Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: effective_user: (null) Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: release_suffix: _EVUP Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: allow_simulate: 0 Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: repeat_max: 600 Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: configfile: /etc/lirc/lircd.conf Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Options: dynamic_codes: (null) Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Current driver: default Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Driver API version: 3 Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Driver version: 0.10.0 Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Jan 13 20:57:49 vol lircd-0.10.1[1519]: Info: lircd: Opening log, level: Info Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: Using systemd fd Jan 13 20:57:49 vol lircd-0.10.1[1519]: Warning: Running as root Jan 13 20:57:49 vol lircd-0.10.1[1519]: Info: Using remote: lircd.conf. Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: lircd(default) ready, using /var/run/lirc/lircd Jan 13 20:57:49 vol sudo[1482]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:49 vol sudo[1436]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:49 vol volumio[1105]: info: ir_controller: systemctl restart lircd.service succeeded. Jan 13 20:57:49 vol volumio[1105]: info: ir_controller: systemctl restart lircd.service succeeded. Jan 13 20:57:49 vol sudo[1523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service Jan 13 20:57:49 vol sudo[1523]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:49 vol sudo[1526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service Jan 13 20:57:49 vol sudo[1526]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:57:49 vol systemd[1]: Started Handle events from IR remotes decoded by lircd(8). Jan 13 20:57:49 vol sudo[1523]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:49 vol volumio[1105]: info: ir_controller: systemctl restart irexec.service succeeded. Jan 13 20:57:49 vol systemd[1]: Stopping Handle events from IR remotes decoded by lircd(8)... Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: accepted new client on /var/run/lirc/lircd Jan 13 20:57:49 vol lircd[1519]: lircd-0.10.1[1519]: Notice: accepted new client on /var/run/lirc/lircd Jan 13 20:57:49 vol lircd[1519]: lircd-0.10.1[1519]: Info: [lirc] protocol is enabled Jan 13 20:57:49 vol lircd[1519]: lircd-0.10.1[1519]: Info: removed client Jan 13 20:57:49 vol systemd[1]: irexec.service: Main process exited, code=killed, status=15/TERM Jan 13 20:57:49 vol lircd-0.10.1[1519]: Info: [lirc] protocol is enabled Jan 13 20:57:49 vol systemd[1]: irexec.service: Succeeded. Jan 13 20:57:49 vol lircd-0.10.1[1519]: Info: removed client Jan 13 20:57:49 vol systemd[1]: Stopped Handle events from IR remotes decoded by lircd(8). Jan 13 20:57:49 vol systemd[1]: Started Handle events from IR remotes decoded by lircd(8). Jan 13 20:57:49 vol sudo[1526]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:49 vol volumio[1105]: info: ir_controller: systemctl restart irexec.service succeeded. Jan 13 20:57:49 vol lircd[1519]: lircd-0.10.1[1519]: Notice: accepted new client on /var/run/lirc/lircd Jan 13 20:57:49 vol lircd-0.10.1[1519]: Notice: accepted new client on /var/run/lirc/lircd Jan 13 20:57:49 vol lircd[1519]: lircd-0.10.1[1519]: Info: [lirc] protocol is enabled Jan 13 20:57:49 vol lircd-0.10.1[1519]: Info: [lirc] protocol is enabled Jan 13 20:57:50 vol mpd[1486]: Jan 13 20:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 13 20:57:50 vol volumio[1105]: info: touch_display: Setting screensaver timeout to 45 seconds. Jan 13 20:57:50 vol systemd[1]: Started Music Player Daemon. Jan 13 20:57:50 vol sudo[1409]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:50 vol sudo[1311]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:50 vol sudo[1331]: pam_unix(sudo:session): session closed for user root Jan 13 20:57:50 vol volumio[1105]: info: Completed starting Core Plugins Jan 13 20:57:50 vol volumio[1105]: info: ------------------------------------------- Jan 13 20:57:50 vol volumio[1105]: info: ----- MyVolumio plugins startup ---- Jan 13 20:57:50 vol volumio[1105]: info: ------------------------------------------- Jan 13 20:57:50 vol volumio[1105]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 13 20:57:50 vol volumio[1105]: error: MPD error: The expression evaluated to a falsy value: Jan 13 20:57:50 vol volumio[1105]: assert.ok(self.idling) Jan 13 20:57:50 vol volumio[1105]: error: The expression evaluated to a falsy value: Jan 13 20:57:50 vol volumio[1105]: assert.ok(self.idling) Jan 13 20:57:50 vol volumio[1105]: error: MPD error: The expression evaluated to a falsy value: Jan 13 20:57:50 vol volumio[1105]: assert.ok(self.idling) Jan 13 20:57:50 vol volumio[1105]: error: The expression evaluated to a falsy value: Jan 13 20:57:50 vol volumio[1105]: assert.ok(self.idling) Jan 13 20:57:50 vol volumio[1105]: error: updateQueue error: null Jan 13 20:57:50 vol volumio[1105]: info: MPD running with PID1486 Jan 13 20:57:50 vol volumio[1105]: ,establishing connection Jan 13 20:57:50 vol volumio[1105]: error: updateQueue error: null Jan 13 20:57:51 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 13 20:57:51 vol volumio[1105]: info: Received Get System Info Jan 13 20:57:51 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 13 20:57:51 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 13 20:57:51 vol volumio[1105]: info: Discovery: Getting this device information Jan 13 20:57:51 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:57:51 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:51 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 13 20:57:51 vol volumio[1105]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds Jan 13 20:57:51 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jan 13 20:57:52 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:57:52 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:52 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:57:52 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:55 vol volumio-remote-updater[558]: [2025-01-13 20:57:55] [connect] Successful connection Jan 13 20:57:55 vol volumio-remote-updater[558]: [2025-01-13 20:57:55] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1736830675 101 Jan 13 20:57:55 vol volumio[1105]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 6 Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::volumioGetBrowseSources Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::volumioGetBrowseSources Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::volumioGetBrowseSources Jan 13 20:57:56 vol volumio[1105]: info: Cannot mount NAS Music at system boot, trial number 3 ,retrying in 5 seconds Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 13 20:57:56 vol kernel: rc rc0: two consecutive events of type space Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 13 20:57:56 vol volumio[1105]: info: Discovery: Getting this device information Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:57:56 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:57:56 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 13 20:57:57 vol volumio[1105]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jan 13 20:58:02 vol volumio[1105]: info: Cannot mount NAS Music at system boot, trial number 4 ,retrying in 5 seconds Jan 13 20:58:03 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jan 13 20:58:03 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 20:58:03 vol sudo[1957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Music Jan 13 20:58:03 vol sudo[1957]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:58:03 vol sudo[1957]: pam_unix(sudo:session): session closed for user root Jan 13 20:58:03 vol systemd[1]: mnt-NAS-Music.mount: Succeeded. Jan 13 20:58:03 vol volumio[1105]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jan 13 20:58:03 vol volumio[1105]: verbose: New Socket.io Connection to 192.168.1.193:3000 from 192.168.1.2 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jan 13 20:58:03 vol volumio[1105]: info: Share Music successfully unmounted Jan 13 20:58:03 vol volumio[1105]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jan 13 20:58:03 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jan 13 20:58:03 vol volumio[1105]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jan 13 20:58:03 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 13 20:58:04 vol volumio[1105]: info: Adding plugin bluetooth to MyMusic Plugins Jan 13 20:58:04 vol volumio[1105]: info: Adding plugin multiroom to MyMusic Plugins Jan 13 20:58:04 vol volumio[1105]: info: Adding plugin metavolumio to MyMusic Plugins Jan 13 20:58:04 vol volumio[1105]: info: Adding plugin cd_controller to MyMusic Plugins Jan 13 20:58:04 vol volumio[1105]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 13 20:58:04 vol volumio[1105]: info: Adding plugin tidalconnect to MyMusic Plugins Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 13 20:58:04 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 20:58:04 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 20:58:04 vol volumio[1105]: info: Starting MyVolumio Remote Streaming Endpoints Jan 13 20:58:04 vol volumio[1105]: info: MyVolumio login type: Token Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 13 20:58:04 vol volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 13 20:58:05 vol volumio[1105]: info: Starting Streaming Service Transparent Proxy Jan 13 20:58:05 vol volumio[1105]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 13 20:58:05 vol volumio[1105]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 13 20:58:05 vol volumio[1105]: info: Streaming services startup Jan 13 20:58:05 vol volumio[1105]: info: Starting Streaming Daemon Jan 13 20:58:05 vol sudo[1969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 13 20:58:05 vol sudo[1969]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 20:58:05 vol sudo[1969]: pam_unix(sudo:session): session closed for user root Jan 13 20:58:05 vol volumio[1105]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jan 13 20:58:05 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 13 20:58:06 vol volumio[1105]: info: Listing playlists Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::volumioGetQueue Jan 13 20:58:06 vol volumio[1105]: info: CoreStateMachine::getQueue Jan 13 20:58:06 vol volumio[1105]: info: CorePlayQueue::getQueue Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::volumioGetVisibleSources Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:58:06 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:58:06 vol volumio[1105]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jan 13 20:58:06 vol volumio[1105]: info: Listing playlists Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::volumioGetQueue Jan 13 20:58:06 vol volumio[1105]: info: CoreStateMachine::getQueue Jan 13 20:58:06 vol volumio[1105]: info: CorePlayQueue::getQueue Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::volumioGetVisibleSources Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:58:06 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:58:06 vol volumio[1105]: info: Listing playlists Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::volumioGetQueue Jan 13 20:58:06 vol volumio[1105]: info: CoreStateMachine::getQueue Jan 13 20:58:06 vol volumio[1105]: info: CorePlayQueue::getQueue Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::volumioGetVisibleSources Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:58:06 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:58:06 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 13 20:58:06 vol volumio[1105]: STREAMING PROXY: Starting server on port 3245 Jan 13 20:58:06 vol volumio[1105]: Node JS runtime: 14 Jan 13 20:58:06 vol volumio[1105]: error: Cannot start Volumio Streaming Daemon Jan 13 20:58:06 vol volumio[1105]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 13 20:58:06 vol volumio[1105]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 13 20:58:06 vol volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Jan 13 20:58:06 vol volumio[1105]: info: Jan 13 20:58:06 vol volumio[1105]: ---------------------------- MPD announces state update: update Jan 13 20:58:06 vol volumio[1105]: info: ControllerMpd::getState Jan 13 20:58:06 vol volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Jan 13 20:58:06 vol volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Jan 13 20:58:06 vol volumio[1105]: info: Jan 13 20:58:06 vol volumio[1105]: ---------------------------- MPD announces state update: update Jan 13 20:58:06 vol volumio[1105]: info: ControllerMpd::getState Jan 13 20:58:06 vol volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Jan 13 20:58:06 vol volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Jan 13 20:58:06 vol volumio[1105]: info: Jan 13 20:58:06 vol volumio[1105]: ---------------------------- MPD announces state update: update Jan 13 20:58:06 vol volumio[1105]: info: ControllerMpd::getState Jan 13 20:58:06 vol volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Jan 13 20:58:06 vol volumio[1105]: info: [1736830686961] Database update started Jan 13 20:58:07 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 13 20:58:07 vol volumio[1105]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 13 20:58:07 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 13 20:58:07 vol volumio[1105]: info: Received Get System Version Jan 13 20:58:07 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 13 20:58:07 vol volumio[1105]: info: Received Get System Info Jan 13 20:58:07 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 13 20:58:07 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 13 20:58:07 vol volumio[1105]: info: Discovery: Getting this device information Jan 13 20:58:07 vol volumio[1105]: info: CoreCommandRouter::volumioGetState Jan 13 20:58:07 vol volumio[1105]: info: CorePlayQueue::getTrack 0 Jan 13 20:58:07 vol volumio[1105]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 13 20:58:07 vol volumio[1105]: error: MyVolumio Custom Token format not valid, refreshing it Jan 13 20:58:07 vol nmbd[761]: [2025/01/13 20:58:07.196795, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 13 20:58:07 vol nmbd[761]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Jan 13 20:58:07 vol volumio[1105]: info: [now-playing] OpenWeatherMap API key obtained. Jan 13 20:58:07 vol volumio[1105]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 20:58:07 vol volumio[1105]: TypeError: Cannot read property 'replace' of undefined Jan 13 20:58:07 vol volumio[1105]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Jan 13 20:58:07 vol volumio[1105]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Jan 13 20:58:07 vol volumio[1105]: at listOnTimeout (internal/timers.js:554:17) Jan 13 20:58:07 vol volumio[1105]: at processTimers (internal/timers.js:497:7) Jan 13 20:58:07 vol volumio[1105]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 20:58:07 vol sudo[1991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-13 20:57 Jan 13 20:58:07 vol sudo[1991]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"