-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Tue 2024-11-26 14:52:11 CET. -- Nov 26 14:51:00 volumio02 sh[488]: eth0: soliciting a DHCP lease Nov 26 14:51:00 volumio02 dhcpcd[520]: eth0: soliciting a DHCP lease Nov 26 14:51:00 volumio02 systemd[1]: Started Raise network interfaces. Nov 26 14:51:00 volumio02 volumio-remote-updater[595]: Error: No active session Nov 26 14:51:00 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:00] [info] asio async_connect error: system:111 (Connection refused) Nov 26 14:51:00 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 26 14:51:00 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:00] [error] handle_connect error: Underlying Transport Error Nov 26 14:51:00 volumio02 systemd[1]: Started Avahi mDNS/DNS-SD Stack. Nov 26 14:51:00 volumio02 systemd[1]: Started WPA supplicant. Nov 26 14:51:00 volumio02 sh[488]: eth0: offered 192.168.101.102 from 192.168.101.1 Nov 26 14:51:00 volumio02 dhcpcd[520]: eth0: offered 192.168.101.102 from 192.168.101.1 Nov 26 14:51:00 volumio02 sh[488]: eth0: probing address 192.168.101.102/24 Nov 26 14:51:00 volumio02 dhcpcd[520]: eth0: probing address 192.168.101.102/24 Nov 26 14:51:00 volumio02 volumio[565]: Could not open config: /tmp/upmpdcli.conf Nov 26 14:51:00 volumio02 volumio-time-update[563]: volumio-time-update-util: Date not found in response Nov 26 14:51:00 volumio02 volumio-time-update[563]: volumio-time-update-util: Retrying in 5 seconds... Nov 26 14:51:00 volumio02 systemd[1]: Listening on mpd.socket. Nov 26 14:51:00 volumio02 systemd[1]: Reached target Network. Nov 26 14:51:00 volumio02 systemd[1]: Starting Music Player Daemon... Nov 26 14:51:00 volumio02 systemd[1]: Reached target Network is Online. Nov 26 14:51:00 volumio02 systemd[1]: Starting LSB: Brings up/down network automatically... Nov 26 14:51:00 volumio02 systemd[1]: Starting Samba NMB Daemon... Nov 26 14:51:00 volumio02 systemd[1]: Starting OpenBSD Secure Shell server... Nov 26 14:51:00 volumio02 systemd[1]: Starting Daily apt download activities... Nov 26 14:51:00 volumio02 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 26 14:51:00 volumio02 systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Nov 26 14:51:00 volumio02 systemd[1]: Starting /etc/rc.local Compatibility... Nov 26 14:51:00 volumio02 systemd[1]: Starting Permit User Sessions... Nov 26 14:51:00 volumio02 systemd[1]: Starting Network Time Service... Nov 26 14:51:00 volumio02 systemd[1]: Starting Raspberry Pi bluetooth helper... Nov 26 14:51:00 volumio02 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Nov 26 14:51:00 volumio02 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Nov 26 14:51:00 volumio02 systemd[1]: Started /etc/rc.local Compatibility. Nov 26 14:51:00 volumio02 systemd[1]: Started Permit User Sessions. Nov 26 14:51:00 volumio02 systemd[1]: iptables.service: Succeeded. Nov 26 14:51:01 volumio02 bthelper[713]: Raspberry Pi BDADDR already set Nov 26 14:51:01 volumio02 systemd[1]: Starting Hold until boot process finishes up... Nov 26 14:51:01 volumio02 systemd[1]: Starting Terminate Plymouth Boot Screen... Nov 26 14:51:01 volumio02 systemd[1]: Started Raspberry Pi bluetooth helper. Nov 26 14:51:01 volumio02 loadcpufreq[622]: Loading cpufreq kernel modules...done (none). Nov 26 14:51:01 volumio02 systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Nov 26 14:51:01 volumio02 systemd[1]: Starting LSB: set CPUFreq kernel parameters... Nov 26 14:51:01 volumio02 systemd[1]: Starting Bluetooth service... Nov 26 14:51:01 volumio02 systemd[1]: Received SIGRTMIN+21 from PID 181 (plymouthd). Nov 26 14:51:01 volumio02 haveged[516]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Nov 26 14:51:01 volumio02 haveged[516]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Nov 26 14:51:01 volumio02 haveged[516]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00225 Nov 26 14:51:01 volumio02 haveged[516]: haveged: fills: 0, generated: 0 Nov 26 14:51:01 volumio02 systemd[1]: Received SIGRTMIN+21 from PID 181 (plymouthd). Nov 26 14:51:01 volumio02 systemd[1]: plymouth-quit-wait.service: Succeeded. Nov 26 14:51:01 volumio02 systemd[1]: Started Hold until boot process finishes up. Nov 26 14:51:01 volumio02 systemd[1]: plymouth-quit.service: Succeeded. Nov 26 14:51:01 volumio02 systemd[1]: Started Terminate Plymouth Boot Screen. Nov 26 14:51:01 volumio02 sshd[752]: Server listening on 0.0.0.0 port 22. Nov 26 14:51:01 volumio02 sshd[752]: Server listening on :: port 22. Nov 26 14:51:01 volumio02 systemd[1]: Started OpenBSD Secure Shell server. Nov 26 14:51:01 volumio02 ifplugd(eth0)[763]: ifplugd 0.28 initializing. Nov 26 14:51:01 volumio02 ifplugd(eth0)[763]: Using interface eth0/B8:27:EB:9A:B4:59 with driver (version: 6.6.56-v7+) Nov 26 14:51:01 volumio02 ifplugd(eth0)[763]: Using detection mode: SIOCETHTOOL Nov 26 14:51:01 volumio02 ifplugd(eth0)[763]: Initialization complete, link beat detected. Nov 26 14:51:01 volumio02 systemd[1]: Started Getty on tty1. Nov 26 14:51:01 volumio02 systemd[1]: Reached target Login Prompts. Nov 26 14:51:01 volumio02 ifplugd(eth0)[763]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Nov 26 14:51:01 volumio02 ntpd[710]: ntpd 4.2.8p12@1.3728-o (1): Starting Nov 26 14:51:01 volumio02 ntpd[710]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Nov 26 14:51:01 volumio02 ntpd[767]: proto: precision = 1.458 usec (-19) Nov 26 14:51:01 volumio02 systemd[1]: Started Network Time Service. Nov 26 14:51:01 volumio02 ntpd[767]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Nov 26 14:51:01 volumio02 ntpd[767]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Nov 26 14:51:01 volumio02 ntpd[767]: Listen and drop on 0 v6wildcard [::]:123 Nov 26 14:51:01 volumio02 ntpd[767]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 26 14:51:01 volumio02 ntpd[767]: Listen normally on 2 lo 127.0.0.1:123 Nov 26 14:51:01 volumio02 ntpd[767]: Listening on routing socket on fd #19 for interface updates Nov 26 14:51:01 volumio02 ntpd[767]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 26 14:51:01 volumio02 ntpd[767]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 26 14:51:01 volumio02 ifplugd(eth0)[763]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Nov 26 14:51:01 volumio02 cpufrequtils[748]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Nov 26 14:51:01 volumio02 systemd[1]: Started LSB: set CPUFreq kernel parameters. Nov 26 14:51:01 volumio02 sudo[693]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 26 14:51:01 volumio02 sudo[693]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:01 volumio02 sudo[693]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Nov 26 14:51:01 volumio02 sudo[693]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:01 volumio02 bluetoothd[751]: Bluetooth daemon 5.50 Nov 26 14:51:02 volumio02 bluetoothd[751]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Nov 26 14:51:02 volumio02 systemd[1]: Started Bluetooth service. Nov 26 14:51:02 volumio02 systemd[1]: Reached target Bluetooth. Nov 26 14:51:02 volumio02 bluetoothd[751]: Starting SDP server Nov 26 14:51:02 volumio02 bluetoothd[751]: Excluding (cli) sap Nov 26 14:51:02 volumio02 kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Nov 26 14:51:02 volumio02 kernel: Bluetooth: BNEP filters: protocol multicast Nov 26 14:51:02 volumio02 kernel: Bluetooth: BNEP socket layer initialized Nov 26 14:51:02 volumio02 bluetoothd[751]: Bluetooth management interface 1.22 initialized Nov 26 14:51:02 volumio02 kernel: Bluetooth: MGMT ver 1.22 Nov 26 14:51:02 volumio02 dbus-daemon[582]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=751 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Nov 26 14:51:02 volumio02 bluetoothd[751]: Failed to set privacy: Rejected (0x0b) Nov 26 14:51:02 volumio02 ntpd[767]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Nov 26 14:51:02 volumio02 systemd[1]: Starting Hostname Service... Nov 26 14:51:02 volumio02 systemd[1]: systemd-rfkill.service: Succeeded. Nov 26 14:51:02 volumio02 dbus-daemon[582]: [system] Successfully activated service 'org.freedesktop.hostname1' Nov 26 14:51:02 volumio02 systemd[1]: Started Hostname Service. Nov 26 14:51:03 volumio02 ntpd[767]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Nov 26 14:51:04 volumio02 nmbd[728]: [2024/11/26 14:51:04.192837, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Nov 26 14:51:04 volumio02 nmbd[728]: started asyncdns process 810 Nov 26 14:51:04 volumio02 nmbd[728]: [2024/11/26 14:51:04.197931, 0] ../lib/util/become_daemon.c:149(daemon_status) Nov 26 14:51:04 volumio02 nmbd[728]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Nov 26 14:51:04 volumio02 nmbd[728]: [2024/11/26 14:51:04.198184, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Nov 26 14:51:04 volumio02 nmbd[728]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Nov 26 14:51:04 volumio02 ntpd[767]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Nov 26 14:51:05 volumio02 wireless.js[593]: Cleaning previous... Nov 26 14:51:05 volumio02 sudo[818]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Nov 26 14:51:05 volumio02 sudo[818]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:05 volumio02 sudo[818]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:05 volumio02 sudo[820]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Nov 26 14:51:05 volumio02 sudo[820]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:05 volumio02 volumio-time-update[563]: volumio-time-update-util: Fetching time from Volumio... Nov 26 14:51:05 volumio02 volumio-time-update[563]: volumio-time-update-util: Date not found in response Nov 26 14:51:05 volumio02 volumio-time-update[563]: volumio-time-update-util: Retrying in 5 seconds... Nov 26 14:51:05 volumio02 ntpd[767]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Nov 26 14:51:05 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:05] [info] asio async_connect error: system:111 (Connection refused) Nov 26 14:51:05 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:05] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 26 14:51:05 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:05] [error] handle_connect error: Underlying Transport Error Nov 26 14:51:05 volumio02 sudo[820]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:05 volumio02 sh[488]: eth0: leased 192.168.101.102 for 86400 seconds Nov 26 14:51:05 volumio02 sh[488]: eth0: adding route to 192.168.101.0/24 Nov 26 14:51:05 volumio02 sh[488]: eth0: adding default route via 192.168.101.1 Nov 26 14:51:05 volumio02 dhcpcd[520]: eth0: leased 192.168.101.102 for 86400 seconds Nov 26 14:51:05 volumio02 dhcpcd[520]: eth0: adding route to 192.168.101.0/24 Nov 26 14:51:05 volumio02 dhcpcd[520]: eth0: adding default route via 192.168.101.1 Nov 26 14:51:05 volumio02 avahi-daemon[555]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.101.102. Nov 26 14:51:05 volumio02 avahi-daemon[555]: New relevant interface eth0.IPv4 for mDNS. Nov 26 14:51:05 volumio02 avahi-daemon[555]: Registering new address record for 192.168.101.102 on eth0.IPv4. Nov 26 14:51:05 volumio02 wireless.js[593]: Stopped aP Nov 26 14:51:05 volumio02 sh[488]: forked to background, child pid 854 Nov 26 14:51:05 volumio02 dhcpcd[520]: forked to background, child pid 854 Nov 26 14:51:05 volumio02 sudo[851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 26 14:51:05 volumio02 sudo[851]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:05 volumio02 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 26 14:51:05 volumio02 sudo[851]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:05 volumio02 sudo[858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Nov 26 14:51:05 volumio02 sudo[858]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:05 volumio02 sudo[858]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:05 volumio02 sudo[879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 26 14:51:05 volumio02 sudo[879]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:06 volumio02 sudo[879]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:06 volumio02 sudo[889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Nov 26 14:51:06 volumio02 sudo[889]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:06 volumio02 ifplugd(eth0)[763]: client: ifup: interface eth0 already configured Nov 26 14:51:06 volumio02 sh[488]: eth0=eth0 Nov 26 14:51:06 volumio02 bthelper[713]: Changing power off succeeded Nov 26 14:51:06 volumio02 ifplugd(eth0)[763]: Program executed successfully. Nov 26 14:51:06 volumio02 ifplugd[694]: Network Interface Plugging Daemon...start eth0...done. Nov 26 14:51:06 volumio02 systemd[1]: Started LSB: Brings up/down network automatically. Nov 26 14:51:06 volumio02 bthelper[713]: [CHG] Controller B8:27:EB:30:1E:F3 Class: 0x0000041c Nov 26 14:51:06 volumio02 bthelper[713]: Changing power on succeeded Nov 26 14:51:06 volumio02 bthelper[713]: [CHG] Controller B8:27:EB:30:1E:F3 Powered: yes Nov 26 14:51:06 volumio02 systemd[1]: apt-daily.service: Succeeded. Nov 26 14:51:06 volumio02 systemd[1]: Started Daily apt download activities. Nov 26 14:51:07 volumio02 mpd[788]: Nov 26 14:51 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 26 14:51:07 volumio02 ntpd[767]: Listen normally on 3 eth0 192.168.101.102:123 Nov 26 14:51:07 volumio02 ntpd[767]: new interface(s) found: waking up resolver Nov 26 14:51:07 volumio02 systemd[1]: Started Music Player Daemon. Nov 26 14:51:07 volumio02 mpd_monitor.sh[601]: MPD restarted due to no mpc output. Nov 26 14:51:08 volumio02 sudo[889]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:08 volumio02 wireless.js[593]: SETTING APPROPRIATE REG DOMAIN: EU Nov 26 14:51:08 volumio02 sudo[932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 26 14:51:08 volumio02 sudo[932]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:08 volumio02 sudo[932]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:08 volumio02 sudo[934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set EU Nov 26 14:51:08 volumio02 sudo[934]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:08 volumio02 sudo[934]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:08 volumio02 wireless.js[593]: SUCCESSFULLY SET NEW REGDOMAIN: EU Nov 26 14:51:08 volumio02 wireless.js[593]: Start wireless flow Nov 26 14:51:08 volumio02 wireless.js[593]: Stopped hotspot (if there).. Nov 26 14:51:08 volumio02 systemd-udevd[343]: Process '/sbin/crda' failed with exit code 255. Nov 26 14:51:08 volumio02 sudo[940]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Nov 26 14:51:08 volumio02 sudo[940]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:08 volumio02 sudo[940]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:08 volumio02 sudo[942]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Nov 26 14:51:08 volumio02 sudo[942]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:09 volumio02 sudo[942]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:09 volumio02 nmbd[728]: [2024/11/26 14:51:09.441178, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 26 14:51:09 volumio02 systemd[1]: Started Samba NMB Daemon. Nov 26 14:51:09 volumio02 nmbd[728]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Nov 26 14:51:09 volumio02 wireless.js[593]: DHCP IP Nov 26 14:51:09 volumio02 wireless.js[593]: Start ap Nov 26 14:51:09 volumio02 wpa_supplicant[944]: Successfully initialized wpa_supplicant Nov 26 14:51:09 volumio02 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 26 14:51:09 volumio02 sudo[946]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Nov 26 14:51:09 volumio02 sudo[946]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:09 volumio02 systemd[1]: Starting Samba Winbind Daemon... Nov 26 14:51:09 volumio02 dhcpcd[948]: dev: loaded udev Nov 26 14:51:09 volumio02 dhcpcd-run-hooks[957]: wlan0: starting wpa_supplicant Nov 26 14:51:09 volumio02 winbindd[945]: [2024/11/26 14:51:09.799686, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Nov 26 14:51:09 volumio02 winbindd[945]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 26 14:51:09 volumio02 winbindd[945]: [2024/11/26 14:51:09.825888, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 26 14:51:09 volumio02 systemd[1]: Started Samba Winbind Daemon. Nov 26 14:51:09 volumio02 winbindd[945]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 26 14:51:09 volumio02 systemd[1]: Starting Samba SMB Daemon... Nov 26 14:51:09 volumio02 dhcpcd-run-hooks[966]: wlan0: failed to start wpa_supplicant Nov 26 14:51:09 volumio02 dhcpcd-run-hooks[967]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Nov 26 14:51:09 volumio02 dhcpcd[948]: wlan0: connected to Access Point `' Nov 26 14:51:09 volumio02 dhcpcd[948]: DUID 00:01:00:01:2d:bb:b4:89:b8:27:eb:4d:64:1f Nov 26 14:51:09 volumio02 dhcpcd[948]: eth0: IAID eb:9a:b4:59 Nov 26 14:51:09 volumio02 dhcpcd[948]: eth0: adding address fe80::2e15:1ff:db97:32ac Nov 26 14:51:09 volumio02 dhcpcd[948]: ipv6_addaddr1: Permission denied Nov 26 14:51:09 volumio02 dhcpcd[948]: wlan0: waiting for carrier Nov 26 14:51:10 volumio02 smbd[965]: [2024/11/26 14:51:10.355634, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 26 14:51:10 volumio02 systemd[1]: Started Samba SMB Daemon. Nov 26 14:51:10 volumio02 smbd[965]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 26 14:51:10 volumio02 volumio-time-update[563]: volumio-time-update-util: Fetching time from Volumio... Nov 26 14:51:10 volumio02 wireless.js[593]: trying... Nov 26 14:51:10 volumio02 sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:10 volumio02 sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:10 volumio02 sudo[997]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:10 volumio02 volumio-time-update[563]: volumio-time-update-util: Setting system time to: 2024-11-26 14:51:35 Nov 26 14:51:10 volumio02 sudo[1000]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2024-11-26 14:51:35 Nov 26 14:51:10 volumio02 sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:10 volumio02 dbus-daemon[582]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.10' (uid=0 pid=1001 comm="timedatectl set-time 2024-11-26 14:51:35 ") Nov 26 14:51:10 volumio02 dhcpcd[948]: eth0: soliciting an IPv6 router Nov 26 14:51:10 volumio02 systemd[1]: Starting Time & Date Service... Nov 26 14:51:10 volumio02 dbus-daemon[582]: [system] Successfully activated service 'org.freedesktop.timedate1' Nov 26 14:51:10 volumio02 systemd[1]: Started Time & Date Service. Nov 26 14:51:35 volumio02 systemd-timedated[1002]: Changed local time to Tue Nov 26 14:51:35 2024 Nov 26 14:51:35 volumio02 sudo[1000]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:35 volumio02 volumio-time-update[563]: volumio-time-update-util: System time updated successfully. Nov 26 14:51:35 volumio02 systemd[1]: Started Volumio Time Update Utility. Nov 26 14:51:35 volumio02 dhcpcd[948]: eth0: rebinding lease of 192.168.101.102 Nov 26 14:51:35 volumio02 dhcpcd[948]: eth0: leased 192.168.101.102 for 86400 seconds Nov 26 14:51:35 volumio02 dhcpcd[948]: eth0: adding route to 192.168.101.0/24 Nov 26 14:51:35 volumio02 dhcpcd[948]: eth0: adding default route via 192.168.101.1 Nov 26 14:51:35 volumio02 dhcpcd[948]: forked to background, child pid 1024 Nov 26 14:51:35 volumio02 sudo[946]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:35 volumio02 wireless.js[593]: trying... Nov 26 14:51:35 volumio02 sudo[1026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:35 volumio02 sudo[1026]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:35 volumio02 sudo[1026]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:36 volumio02 wpa_supplicant[961]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Nov 26 14:51:36 volumio02 wireless.js[593]: trying... Nov 26 14:51:36 volumio02 sudo[1029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:36 volumio02 sudo[1029]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:36 volumio02 sudo[1029]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:37 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:37] [info] asio async_connect error: system:111 (Connection refused) Nov 26 14:51:37 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:37] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 26 14:51:37 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:37] [error] handle_connect error: Underlying Transport Error Nov 26 14:51:37 volumio02 wireless.js[593]: trying... Nov 26 14:51:37 volumio02 sudo[1032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:37 volumio02 sudo[1032]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:37 volumio02 sudo[1032]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:37 volumio02 kernel: brcmfmac: brcmf_set_channel: set chanspec 0x100c fail, reason -52 Nov 26 14:51:37 volumio02 kernel: brcmfmac: brcmf_set_channel: set chanspec 0x100d fail, reason -52 Nov 26 14:51:37 volumio02 kernel: brcmfmac: brcmf_set_channel: set chanspec 0x100e fail, reason -52 Nov 26 14:51:37 volumio02 kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Nov 26 14:51:37 volumio02 kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Nov 26 14:51:38 volumio02 kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Nov 26 14:51:38 volumio02 kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Nov 26 14:51:38 volumio02 wireless.js[593]: trying... Nov 26 14:51:38 volumio02 sudo[1035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:38 volumio02 sudo[1035]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:38 volumio02 sudo[1035]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:39 volumio02 wireless.js[593]: trying... Nov 26 14:51:39 volumio02 sudo[1038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:39 volumio02 sudo[1038]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:39 volumio02 sudo[1038]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:40 volumio02 wpa_supplicant[961]: wlan0: Trying to associate with SSID 'hylea.net@falemez' Nov 26 14:51:40 volumio02 wireless.js[593]: trying... Nov 26 14:51:40 volumio02 sudo[1041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:40 volumio02 sudo[1041]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:40 volumio02 sudo[1041]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:40 volumio02 dhcpcd[1024]: wlan0: carrier acquired Nov 26 14:51:40 volumio02 dhcpcd[1024]: wlan0: connected to Access Point `hylea.net@falemez' Nov 26 14:51:40 volumio02 wpa_supplicant[961]: wlan0: Associated with 08:bf:b8:25:d2:7c Nov 26 14:51:40 volumio02 wpa_supplicant[961]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:bf:b8:25:d2:7c completed [id=0 id_str=] Nov 26 14:51:40 volumio02 wpa_supplicant[961]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Nov 26 14:51:40 volumio02 wpa_supplicant[961]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Nov 26 14:51:40 volumio02 dhcpcd[1024]: wlan0: IAID eb:cf:e1:0c Nov 26 14:51:40 volumio02 dhcpcd[1024]: wlan0: adding address fe80::dd61:8ccf:b41:b8f9 Nov 26 14:51:40 volumio02 dhcpcd[1024]: ipv6_addaddr1: Permission denied Nov 26 14:51:40 volumio02 dhcpcd[1024]: wlan0: carrier lost Nov 26 14:51:40 volumio02 dhcpcd[1024]: wlan0: carrier acquired Nov 26 14:51:40 volumio02 dhcpcd[1024]: wlan0: IAID eb:cf:e1:0c Nov 26 14:51:41 volumio02 dhcpcd[1024]: wlan0: rebinding lease of 192.168.101.101 Nov 26 14:51:41 volumio02 wireless.js[593]: trying... Nov 26 14:51:41 volumio02 sudo[1065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:41 volumio02 sudo[1065]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:41 volumio02 sudo[1065]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:41 volumio02 dhcpcd[1024]: wlan0: soliciting an IPv6 router Nov 26 14:51:42 volumio02 wireless.js[593]: trying... Nov 26 14:51:42 volumio02 sudo[1071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:42 volumio02 sudo[1071]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:42 volumio02 sudo[1071]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:43 volumio02 wireless.js[593]: trying... Nov 26 14:51:43 volumio02 sudo[1074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:43 volumio02 sudo[1074]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:43 volumio02 sudo[1074]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:44 volumio02 wireless.js[593]: trying... Nov 26 14:51:44 volumio02 sudo[1077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:44 volumio02 sudo[1077]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:44 volumio02 sudo[1077]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:45 volumio02 wireless.js[593]: trying... Nov 26 14:51:45 volumio02 sudo[1080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:45 volumio02 sudo[1080]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:45 volumio02 sudo[1080]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:46 volumio02 dhcpcd[1024]: wlan0: probing for an IPv4LL address Nov 26 14:51:46 volumio02 dhcpcd[1024]: wlan0: DHCP lease expired Nov 26 14:51:46 volumio02 dhcpcd[1024]: wlan0: soliciting a DHCP lease Nov 26 14:51:46 volumio02 dhcpcd[1024]: wlan0: offered 192.168.101.101 from 192.168.101.1 Nov 26 14:51:46 volumio02 dhcpcd[1024]: wlan0: probing address 192.168.101.101/24 Nov 26 14:51:46 volumio02 wireless.js[593]: trying... Nov 26 14:51:46 volumio02 sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:46 volumio02 sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:46 volumio02 sudo[1100]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:47 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:47] [info] asio async_connect error: system:111 (Connection refused) Nov 26 14:51:47 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 26 14:51:47 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:47] [error] handle_connect error: Underlying Transport Error Nov 26 14:51:47 volumio02 wireless.js[593]: trying... Nov 26 14:51:47 volumio02 sudo[1103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:47 volumio02 sudo[1103]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:47 volumio02 sudo[1103]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:48 volumio02 wireless.js[593]: trying... Nov 26 14:51:48 volumio02 sudo[1106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:48 volumio02 sudo[1106]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:48 volumio02 sudo[1106]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:49 volumio02 wireless.js[593]: trying... Nov 26 14:51:49 volumio02 sudo[1109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:49 volumio02 sudo[1109]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:49 volumio02 sudo[1109]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:49 volumio02 systemd[1]: systemd-fsckd.service: Succeeded. Nov 26 14:51:50 volumio02 wireless.js[593]: trying... Nov 26 14:51:50 volumio02 sudo[1112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:50 volumio02 sudo[1112]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:50 volumio02 sudo[1112]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:51 volumio02 dhcpcd[1024]: wlan0: using IPv4LL address 169.254.134.137 Nov 26 14:51:51 volumio02 avahi-daemon[555]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.134.137. Nov 26 14:51:51 volumio02 avahi-daemon[555]: New relevant interface wlan0.IPv4 for mDNS. Nov 26 14:51:51 volumio02 dhcpcd[1024]: wlan0: adding route to 169.254.0.0/16 Nov 26 14:51:51 volumio02 avahi-daemon[555]: Registering new address record for 169.254.134.137 on wlan0.IPv4. Nov 26 14:51:51 volumio02 dhcpcd[1024]: wlan0: leased 192.168.101.101 for 86400 seconds Nov 26 14:51:51 volumio02 avahi-daemon[555]: Registering new address record for 192.168.101.101 on wlan0.IPv4. Nov 26 14:51:51 volumio02 dhcpcd[1024]: wlan0: adding route to 192.168.101.0/24 Nov 26 14:51:51 volumio02 dhcpcd[1024]: wlan0: adding default route via 192.168.101.1 Nov 26 14:51:51 volumio02 wireless.js[593]: trying... Nov 26 14:51:51 volumio02 sudo[1156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 26 14:51:51 volumio02 sudo[1156]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:51 volumio02 sudo[1156]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:51 volumio02 wireless.js[593]: Connected to: ----hylea.net@falemez Nov 26 14:51:51 volumio02 wireless.js[593]: ---- Nov 26 14:51:51 volumio02 sudo[1159]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 14:51:51 volumio02 sudo[1159]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:51 volumio02 sudo[1159]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:51 volumio02 wireless.js[593]: ... joined AP, wlan0 IPv4 is 169.254.134.137, ipV6 is undefined Nov 26 14:51:51 volumio02 wireless.js[593]: It's done! AP Nov 26 14:51:51 volumio02 avahi-daemon[555]: Withdrawing address record for 169.254.134.137 on wlan0. Nov 26 14:51:51 volumio02 avahi-daemon[555]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.134.137. Nov 26 14:51:51 volumio02 avahi-daemon[555]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.101.101. Nov 26 14:51:51 volumio02 dhcpcd[1024]: wlan0: deleting route to 169.254.0.0/16 Nov 26 14:51:51 volumio02 systemd[1]: Started Wireless Services. Nov 26 14:51:51 volumio02 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 26 14:51:51 volumio02 systemd[1]: Started Volumio Backend Module. Nov 26 14:51:51 volumio02 systemd[1]: Started Volumio Cpu Tweaker. Nov 26 14:51:51 volumio02 systemd[1]: Reached target Multi-User System. Nov 26 14:51:51 volumio02 systemd[1]: Reached target Graphical Interface. Nov 26 14:51:51 volumio02 systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 26 14:51:51 volumio02 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 26 14:51:51 volumio02 volumio-cpu-tweak[1183]: Setting RT Priority for mpd Nov 26 14:51:51 volumio02 systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 26 14:51:51 volumio02 systemd[1]: Startup finished in 15.906s (kernel) + 37.111s (userspace) = 53.017s. Nov 26 14:51:51 volumio02 volumio-cpu-tweak[1183]: Setting MPD Affinity Nov 26 14:51:51 volumio02 volumio-cpu-tweak[1183]: pid 788's current affinity mask: f Nov 26 14:51:51 volumio02 volumio-cpu-tweak[1183]: pid 788's new affinity mask: 3 Nov 26 14:51:51 volumio02 volumio-cpu-tweak[1183]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Nov 26 14:51:51 volumio02 volumio-cpu-tweak[1183]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Nov 26 14:51:51 volumio02 systemd[1]: volumio_cpu_tweak.service: Succeeded. Nov 26 14:51:52 volumio02 ntpd[767]: Listen normally on 4 wlan0 192.168.101.101:123 Nov 26 14:51:52 volumio02 ntpd[767]: new interface(s) found: waking up resolver Nov 26 14:51:54 volumio02 volumio[1182]: info: ------------------------------------------- Nov 26 14:51:54 volumio02 volumio[1182]: info: ----- Volumio3 ---- Nov 26 14:51:54 volumio02 volumio[1182]: info: ------------------------------------------- Nov 26 14:51:54 volumio02 volumio[1182]: info: ----- System startup ---- Nov 26 14:51:54 volumio02 volumio[1182]: info: ------------------------------------------- Nov 26 14:51:55 volumio02 volumio[1182]: info: MYVOLUMIO Environment detected Nov 26 14:51:55 volumio02 volumio[1182]: info: Plugin folders cleanup Nov 26 14:51:55 volumio02 volumio[1182]: info: Scanning into folder /volumio/app/plugins/ Nov 26 14:51:55 volumio02 volumio[1182]: info: Scanning category audio_interface Nov 26 14:51:55 volumio02 volumio[1182]: info: Scanning category miscellanea Nov 26 14:51:55 volumio02 volumio[1182]: info: Scanning category music_service Nov 26 14:51:55 volumio02 volumio[1182]: info: Scanning category plugins.json Nov 26 14:51:55 volumio02 volumio[1182]: info: Scanning category system_controller Nov 26 14:51:55 volumio02 volumio[1182]: info: Scanning category user_interface Nov 26 14:51:55 volumio02 volumio[1182]: info: Scanning into folder /data/plugins/ Nov 26 14:51:55 volumio02 volumio[1182]: info: Scanning category music_service Nov 26 14:51:55 volumio02 volumio[1182]: info: Scanning category system_controller Nov 26 14:51:55 volumio02 volumio[1182]: info: Scanning category user_interface Nov 26 14:51:55 volumio02 volumio[1182]: info: Plugin folders cleanup completed Nov 26 14:51:55 volumio02 volumio[1182]: info: ------------------------------------------- Nov 26 14:51:55 volumio02 volumio[1182]: info: ----- Core plugins startup ---- Nov 26 14:51:55 volumio02 volumio[1182]: info: ------------------------------------------- Nov 26 14:51:55 volumio02 volumio[1182]: info: Loading plugins from folder /volumio/app/plugins/ Nov 26 14:51:55 volumio02 volumio[1182]: info: Adding plugin upnp to MyMusic Plugins Nov 26 14:51:55 volumio02 volumio[1182]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 26 14:51:55 volumio02 volumio[1182]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 26 14:51:55 volumio02 volumio[1182]: info: Loading plugins from folder /data/plugins/ Nov 26 14:51:55 volumio02 volumio[1182]: info: Loading plugin "system"... Nov 26 14:51:55 volumio02 volumio[1182]: info: Loading plugin "appearance"... Nov 26 14:51:56 volumio02 systemd[1]: systemd-hostnamed.service: Succeeded. Nov 26 14:51:57 volumio02 volumio[1182]: info: Loading plugin "network"... Nov 26 14:51:57 volumio02 volumio[1182]: info: Refreshing Cached IP Addresses Nov 26 14:51:57 volumio02 sudo[1220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 14:51:57 volumio02 sudo[1220]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:57 volumio02 sudo[1222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 14:51:57 volumio02 sudo[1222]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:57 volumio02 sudo[1220]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:57 volumio02 volumio[1182]: info: Loading plugin "services"... Nov 26 14:51:57 volumio02 sudo[1222]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:57 volumio02 volumio[1182]: info: Loading plugin "alsa_controller"... Nov 26 14:51:57 volumio02 sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 26 14:51:57 volumio02 sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:57 volumio02 volumio-remote-updater[595]: [2024-11-26 14:51:57] [connect] Successful connection Nov 26 14:51:57 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 14:51:57 volumio02 volumio[1182]: info: Loading plugin "wizard"... Nov 26 14:51:57 volumio02 volumio[1182]: info: Loading plugin "networkfs"... Nov 26 14:51:57 volumio02 volumio[1182]: info: Starting Udev Watcher for removable devices Nov 26 14:51:57 volumio02 sudo[1248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=falemezmc,password=pie0Erieghaemah4,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.101.110/music/ /mnt/NAS/storage01 Nov 26 14:51:57 volumio02 sudo[1248]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:51:57 volumio02 volumio[1182]: info: Ignoring mount for partition: boot Nov 26 14:51:57 volumio02 volumio[1182]: info: Ignoring mount for partition: volumio Nov 26 14:51:57 volumio02 volumio[1182]: info: Ignoring mount for partition: volumio_data Nov 26 14:51:57 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 14:51:57 volumio02 volumio[1182]: info: Loading plugin "volumio_command_line_client"... Nov 26 14:51:57 volumio02 volumio[1182]: info: Loading plugin "upnp"... Nov 26 14:51:57 volumio02 volumio[1182]: info: [1732629117628] Starting Upmpd Daemon Nov 26 14:51:57 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 14:51:57 volumio02 volumio[1182]: info: Loading plugin "my_music"... Nov 26 14:51:57 volumio02 volumio[1182]: info: Loading plugin "mpd"... Nov 26 14:51:57 volumio02 kernel: Key type cifs.spnego registered Nov 26 14:51:57 volumio02 kernel: Key type cifs.idmap registered Nov 26 14:51:57 volumio02 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. Nov 26 14:51:57 volumio02 kernel: CIFS: Attempting to mount //192.168.101.110/music Nov 26 14:51:58 volumio02 sudo[1248]: pam_unix(sudo:session): session closed for user root Nov 26 14:51:58 volumio02 volumio[1182]: info: Loading plugin "upnp_browser"... Nov 26 14:51:58 volumio02 volumio[1182]: info: Loading plugin "alarm-clock"... Nov 26 14:51:58 volumio02 volumio[1182]: info: Loading plugin "airplay_emulation"... Nov 26 14:51:58 volumio02 volumio[1182]: info: Starting Shairport Sync Nov 26 14:51:58 volumio02 volumio[1182]: info: Loading plugin "last_100"... Nov 26 14:51:58 volumio02 volumio[1182]: info: Loading plugin "webradio"... Nov 26 14:51:59 volumio02 volumio[1182]: info: Loading plugin "i2s_dacs"... Nov 26 14:51:59 volumio02 volumio[1182]: info: Loading plugin "volumiodiscovery"... Nov 26 14:51:59 volumio02 volumio[1182]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 14:51:59 volumio02 volumio[1182]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 14:51:59 volumio02 volumio[1182]: *** WARNING *** For more information see Nov 26 14:51:59 volumio02 node[1182]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 26 14:51:59 volumio02 volumio[1182]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 14:51:59 volumio02 volumio[1182]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 14:51:59 volumio02 volumio[1182]: *** WARNING *** For more information see Nov 26 14:51:59 volumio02 node[1182]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 14:51:59 volumio02 node[1182]: *** WARNING *** For more information see Nov 26 14:51:59 volumio02 node[1182]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 26 14:51:59 volumio02 node[1182]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 26 14:51:59 volumio02 node[1182]: *** WARNING *** For more information see Nov 26 14:51:59 volumio02 volumio[1182]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 26 14:51:59 volumio02 volumio[1182]: info: Discovery: Started advertising with name: Volumio02 Nov 26 14:51:59 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 26 14:51:59 volumio02 volumio[1182]: info: Loading plugin "mixcloud"... Nov 26 14:52:00 volumio02 volumio[1182]: info: Loading plugin "soundcloud"... Nov 26 14:52:00 volumio02 volumio[1182]: info: Loading plugin "spop"... Nov 26 14:52:01 volumio02 sudo[1231]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:02 volumio02 volumio[1182]: info: Loading plugin "ytmusic"... Nov 26 14:52:04 volumio02 volumio[1182]: info: Loading plugin "autostart"... Nov 26 14:52:04 volumio02 volumio[1182]: info: Applying required configuration parameters for plugin autostart Nov 26 14:52:04 volumio02 volumio[1182]: info: AutoStart - onVolumioStart - read config.json Nov 26 14:52:04 volumio02 volumio[1182]: info: Loading plugin "outputs"... Nov 26 14:52:04 volumio02 volumio[1182]: info: Loading plugin "albumart"... Nov 26 14:52:04 volumio02 volumio[1182]: info: Plugin example_plugin is not enabled Nov 26 14:52:04 volumio02 volumio[1182]: info: Loading plugin "inputs"... Nov 26 14:52:04 volumio02 volumio[1182]: info: Loading plugin "updater_comm"... Nov 26 14:52:04 volumio02 volumio[1182]: info: Plugin mpdemulation is not enabled Nov 26 14:52:04 volumio02 volumio[1182]: info: Loading plugin "rest_api"... Nov 26 14:52:04 volumio02 volumio[1182]: info: Loading plugin "websocket"... Nov 26 14:52:04 volumio02 volumio[1182]: info: Starting Socket.io Server version 2.3.0 Nov 26 14:52:04 volumio02 volumio[1182]: info: Loading plugin "podcast"... Nov 26 14:52:04 volumio02 volumio[1182]: Forking 3 albumart workers Nov 26 14:52:05 volumio02 systemd[1]: systemd-timedated.service: Succeeded. Nov 26 14:52:05 volumio02 volumio[1182]: info: ControllerPodcast::constructor Nov 26 14:52:05 volumio02 volumio[1182]: info: Loading plugin "Systeminfo"... Nov 26 14:52:06 volumio02 volumio[1182]: Starting albumart workers Nov 26 14:52:06 volumio02 volumio[1182]: Starting albumart workers Nov 26 14:52:06 volumio02 volumio[1182]: Starting albumart workers Nov 26 14:52:06 volumio02 volumio[1182]: info: Loading i18n strings for locale en Nov 26 14:52:06 volumio02 volumio[1182]: Updating browse sources language Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::initPlayerControls Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 14:52:06 volumio02 volumio[1182]: Express server listening on port 3000 Nov 26 14:52:06 volumio02 volumio[1182]: [Metrics] WebUI: 13s 106.11ms Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreStateMachine::resetVolumioState Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreStateMachine::getcurrentVolume Nov 26 14:52:06 volumio02 volumio[1182]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 14:52:06 volumio02 volumio[1182]: info: Volumio Network Manager: Network status updated: 3 Nov 26 14:52:06 volumio02 volumio[1182]: verbose: New Socket.io Connection to 192.168.101.102 from 192.168.101.151 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 1 Nov 26 14:52:07 volumio02 volumio[1182]: verbose: New Socket.io Connection to 192.168.101.101 from 192.168.101.151 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 2 Nov 26 14:52:07 volumio02 volumio[1182]: verbose: New Socket.io Connection to 192.168.101.102 from 192.168.101.151 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 3 Nov 26 14:52:07 volumio02 volumio[1182]: verbose: New Socket.io Connection to 192.168.101.101 from 192.168.101.151 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 4 Nov 26 14:52:07 volumio02 volumio[1182]: verbose: New Socket.io Connection to 192.168.101.101 from 192.168.101.151 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 5 Nov 26 14:52:07 volumio02 volumio[1182]: verbose: New Socket.io Connection to 192.168.101.101 from 192.168.101.151 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 6 Nov 26 14:52:07 volumio02 volumio[1182]: verbose: New Socket.io Connection to 192.168.101.101 from 192.168.101.151 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 7 Nov 26 14:52:07 volumio02 volumio[1182]: verbose: New Socket.io Connection to 192.168.101.102 from 192.168.101.151 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 8 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 14:52:07 volumio02 volumio[1182]: info: Reloading queue from file Nov 26 14:52:07 volumio02 volumio[1182]: verbose: New Socket.io Connection to 192.168.101.102 from 192.168.101.151 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 9 Nov 26 14:52:07 volumio02 volumio[1182]: verbose: New Socket.io Connection to 192.168.101.101 from 192.168.101.151 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 10 Nov 26 14:52:07 volumio02 volumio[1182]: info: VolumeController:: Volume=100 Mute =false Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreStateMachine::pushState Nov 26 14:52:07 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioPushState Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreStateMachine::updateTrackBlock Nov 26 14:52:07 volumio02 volumio[1182]: info: CorePlayQueue::getTrackBlock Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioRetrievevolume Nov 26 14:52:07 volumio02 volumio[1182]: info: Setting Device type: Raspberry PI Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreStateMachine::setRepeat false single undefined Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreStateMachine::pushState Nov 26 14:52:07 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioPushState Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreStateMachine::setRandom false Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreStateMachine::pushState Nov 26 14:52:07 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioPushState Nov 26 14:52:07 volumio02 volumio[1182]: verbose: New Socket.io Connection to 192.168.101.102 from 192.168.101.151 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 11 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioGetState Nov 26 14:52:07 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:07 volumio02 volumio[1182]: info: Completed loading Core Plugins Nov 26 14:52:07 volumio02 volumio[1182]: info: Preparing to generate the ALSA configuration file Nov 26 14:52:07 volumio02 volumio[1182]: info: Received Get System Info Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 14:52:07 volumio02 volumio[1182]: info: Discovery: Getting this device information Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioGetState Nov 26 14:52:07 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioGetState Nov 26 14:52:07 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioGetVisibleSources Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioGetState Nov 26 14:52:07 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioGetState Nov 26 14:52:07 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 26 14:52:07 volumio02 volumio[1182]: info: Received Get System Info Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 14:52:07 volumio02 volumio[1182]: info: Discovery: Getting this device information Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioGetState Nov 26 14:52:07 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioGetState Nov 26 14:52:07 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:07 volumio02 volumio[1182]: info: Listing playlists Nov 26 14:52:07 volumio02 volumio[1182]: verbose: New Socket.io Connection to 192.168.101.102 from 192.168.101.151 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 12 Nov 26 14:52:07 volumio02 volumio[1182]: info: VolumeController:: Volume=100 Mute =false Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreStateMachine::pushState Nov 26 14:52:07 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioPushState Nov 26 14:52:07 volumio02 volumio[1182]: info: Asound.conf file written Nov 26 14:52:07 volumio02 sudo[1359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 26 14:52:07 volumio02 sudo[1359]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:07 volumio02 sudo[1359]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:07 volumio02 volumio[1182]: info: Output device has changed, restarting MPD Nov 26 14:52:07 volumio02 volumio[1182]: info: Output device has changed, restarting Shairport Sync Nov 26 14:52:07 volumio02 sudo[1364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 14:52:07 volumio02 sudo[1364]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 14:52:07 volumio02 sudo[1364]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:07 volumio02 sudo[1366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 14:52:07 volumio02 sudo[1366]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:07 volumio02 systemd[1]: Stopping Music Player Daemon... Nov 26 14:52:07 volumio02 volumio[1182]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 14:52:07 volumio02 volumio[1182]: info: ___________ START PLUGINS ___________ Nov 26 14:52:07 volumio02 volumio[1182]: info: ControllerMpd::onStart: Initializing MPD Nov 26 14:52:07 volumio02 volumio[1182]: info: Creating MPD Configuration file Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 14:52:07 volumio02 volumio[1182]: info: [1732629127804] CoreMusicLibrary::Adding element Media Servers Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 14:52:07 volumio02 sudo[1373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 26 14:52:07 volumio02 sudo[1373]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:07 volumio02 sudo[1373]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:07 volumio02 sudo[1375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 26 14:52:07 volumio02 sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 14:52:07 volumio02 volumio[1182]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 14:52:07 volumio02 systemd[1]: mpd.service: Succeeded. Nov 26 14:52:07 volumio02 systemd[1]: Stopped Music Player Daemon. Nov 26 14:52:07 volumio02 volumio[1182]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 14:52:07 volumio02 volumio[1182]: info: [1732629127967] CoreMusicLibrary::Adding element Last_100 Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 14:52:07 volumio02 volumio[1182]: info: [1732629127971] CoreMusicLibrary::Adding element Webradio Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 14:52:07 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 14:52:07 volumio02 volumio[1182]: info: Initializing BBC Radios Nov 26 14:52:08 volumio02 systemd[1]: Starting Music Player Daemon... Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 14:52:08 volumio02 volumio[1182]: info: [1732629128063] CoreMusicLibrary::Adding element Mixcloud Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 14:52:08 volumio02 volumio[1182]: Cannot find translation for source Mixcloud Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 14:52:08 volumio02 volumio[1182]: info: [1732629128079] CoreMusicLibrary::Adding element SoundCloud Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 14:52:08 volumio02 volumio[1182]: Cannot find translation for source Mixcloud Nov 26 14:52:08 volumio02 volumio[1182]: Cannot find translation for source SoundCloud Nov 26 14:52:08 volumio02 volumio[1182]: info: Creating Spotify config file Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 sudo[1382]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 26 14:52:08 volumio02 sudo[1382]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:08 volumio02 sudo[1382]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 14:52:08 volumio02 volumio[1182]: info: [1732629128211] CoreMusicLibrary::Adding element YouTube Music Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 14:52:08 volumio02 volumio[1182]: Cannot find translation for source Mixcloud Nov 26 14:52:08 volumio02 volumio[1182]: Cannot find translation for source SoundCloud Nov 26 14:52:08 volumio02 volumio[1182]: Cannot find translation for source YouTube Music Nov 26 14:52:08 volumio02 volumio[1182]: info: AutoStart - onStart Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 14:52:08 volumio02 volumio[1182]: info: [1732629128246] CoreMusicLibrary::Adding element Podcast Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 14:52:08 volumio02 volumio[1182]: Cannot find translation for source Mixcloud Nov 26 14:52:08 volumio02 volumio[1182]: Cannot find translation for source SoundCloud Nov 26 14:52:08 volumio02 volumio[1182]: Cannot find translation for source YouTube Music Nov 26 14:52:08 volumio02 volumio[1182]: Cannot find translation for source Podcast Nov 26 14:52:08 volumio02 volumio[1182]: info: Volumio Calling Home Nov 26 14:52:08 volumio02 sudo[1403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 14:52:08 volumio02 volumio[1182]: info: Discovery: adding 08f79e7e-3178-4655-ac09-84b2b33c793a Nov 26 14:52:08 volumio02 volumio[1182]: info: Discovery: Found device Volumio02 Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::volumioGetState Nov 26 14:52:08 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:08 volumio02 sudo[1403]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:08 volumio02 sudo[1403]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:08 volumio02 volumio[1182]: info: Discovery: this is already registered, 08f79e7e-3178-4655-ac09-84b2b33c793a Nov 26 14:52:08 volumio02 volumio[1182]: info: Discovery: Found device Volumio02 Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::volumioGetState Nov 26 14:52:08 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:08 volumio02 sudo[1405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 14:52:08 volumio02 sudo[1405]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:08 volumio02 sudo[1405]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:08 volumio02 volumio[1182]: info: MPD Permissions set Nov 26 14:52:08 volumio02 volumio[1182]: info: MPD Permissions set Nov 26 14:52:08 volumio02 volumio[1182]: info: Spotify config file written Nov 26 14:52:08 volumio02 volumio[1182]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Nov 26 14:52:08 volumio02 sudo[1409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 sudo[1409]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 26 14:52:08 volumio02 systemd[1]: Started go-librespot Daemon. Nov 26 14:52:08 volumio02 go-librespot[1415]: Librespot-go daemon starting... Nov 26 14:52:08 volumio02 sudo[1409]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::volumioGetQueue Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreStateMachine::getQueue Nov 26 14:52:08 volumio02 volumio[1182]: info: CorePlayQueue::getQueue Nov 26 14:52:08 volumio02 volumio[1182]: info: Volumio called home Nov 26 14:52:08 volumio02 volumio[1182]: info: Starting Shairport Sync Nov 26 14:52:08 volumio02 volumio[1182]: info: Starting Shairport Sync Nov 26 14:52:08 volumio02 volumio[1182]: info: Starting Shairport Sync Nov 26 14:52:08 volumio02 sudo[1422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 26 14:52:08 volumio02 sudo[1422]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:08 volumio02 sudo[1424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 26 14:52:08 volumio02 sudo[1424]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:08 volumio02 sudo[1431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 26 14:52:08 volumio02 sudo[1431]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:08 volumio02 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 26 14:52:08 volumio02 systemd[1]: shairport-sync.service: Succeeded. Nov 26 14:52:08 volumio02 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 26 14:52:08 volumio02 volumio[1182]: info: CoreCommandRouter::volumioGetState Nov 26 14:52:08 volumio02 volumio[1182]: info: CorePlayQueue::getTrack 0 Nov 26 14:52:08 volumio02 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 26 14:52:09 volumio02 sudo[1422]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:09 volumio02 sudo[1424]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:09 volumio02 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 26 14:52:09 volumio02 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 26 14:52:09 volumio02 systemd[1]: shairport-sync.service: Succeeded. Nov 26 14:52:09 volumio02 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 26 14:52:09 volumio02 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 26 14:52:09 volumio02 sudo[1431]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:09 volumio02 sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 26 14:52:09 volumio02 sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 14:52:09 volumio02 systemd[1]: Started UPnP Renderer front-end to MPD. Nov 26 14:52:09 volumio02 sudo[1436]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:09 volumio02 volumio[1182]: info: Upmpdcli Daemon Started Nov 26 14:52:09 volumio02 volumio[1182]: info: Shairport-Sync Started Nov 26 14:52:09 volumio02 go-librespot[1415]: time="2024-11-26T14:52:09+01:00" level=info msg="generated new device id: 1e9631d3de7897f5b2b928fbfced642c03de2751" Nov 26 14:52:09 volumio02 volumio[1182]: Error adding Membership: Error: addMembership EINVAL Nov 26 14:52:09 volumio02 volumio[1182]: info: Shairport-Sync Started Nov 26 14:52:09 volumio02 volumio[1182]: info: Shairport-Sync Started Nov 26 14:52:09 volumio02 go-librespot[1415]: time="2024-11-26T14:52:09+01:00" level=debug msg="stored credentials found for pr-hu" Nov 26 14:52:09 volumio02 volumio[1182]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 26 14:52:09 volumio02 volumio[1182]: SPOTIFY: BQB4X0JbLMObtJWdrXa72D1bh3ggaElIVCgdEZe-8NXcPSllq9FG96LA_0-ywx8lnYTMglZICwYzI5qIwFjs5l-qvhHlpC5jJJDuOt4Bx4mqLKe7FuaSvZGyIHbkQWTSHBgWdv2NDQyA7NT_R9zMbWHBC7vSCjXYfsmSN4g98qpHpvMtpeQtncAstjwFxQp28MKH-Y1EWBFoco1Zuiu68KpDIboZ3jHFw6CgUPWRpAN3fMgE9uw5 Nov 26 14:52:09 volumio02 volumio[1182]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 26 14:52:09 volumio02 volumio[1182]: info: New Spotify access token = BQB4X0JbLMObtJWdrXa72D1bh3ggaElIVCgdEZe-8NXcPSllq9FG96LA_0-ywx8lnYTMglZICwYzI5qIwFjs5l-qvhHlpC5jJJDuOt4Bx4mqLKe7FuaSvZGyIHbkQWTSHBgWdv2NDQyA7NT_R9zMbWHBC7vSCjXYfsmSN4g98qpHpvMtpeQtncAstjwFxQp28MKH-Y1EWBFoco1Zuiu68KpDIboZ3jHFw6CgUPWRpAN3fMgE9uw5 Nov 26 14:52:09 volumio02 volumio[1182]: info: Spotify credentials grant success - running version from March 24, 2019 Nov 26 14:52:09 volumio02 volumio[1182]: SPOTIFY: User informations: {"country":"HU","display_name":"pr-hu","email":"pr@hylea.net","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/pr-hu"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/pr-hu","id":"pr-hu","images":[],"product":"premium","type":"user","uri":"spotify:user:pr-hu"} Nov 26 14:52:09 volumio02 volumio[1182]: info: Spotify Successfully logged in Nov 26 14:52:09 volumio02 volumio[1182]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 26 14:52:09 volumio02 volumio[1182]: info: [1732629129587] CoreMusicLibrary::Adding element Spotify Nov 26 14:52:09 volumio02 volumio[1182]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 14:52:09 volumio02 volumio[1182]: Cannot find translation for source Mixcloud Nov 26 14:52:09 volumio02 volumio[1182]: Cannot find translation for source SoundCloud Nov 26 14:52:09 volumio02 volumio[1182]: Cannot find translation for source YouTube Music Nov 26 14:52:09 volumio02 volumio[1182]: Cannot find translation for source Podcast Nov 26 14:52:09 volumio02 volumio[1182]: Cannot find translation for source Spotify Nov 26 14:52:09 volumio02 go-librespot[1415]: time="2024-11-26T14:52:09+01:00" level=debug msg="obtained new client token: AAAfmvE/0J3MfIPBW3vzPUKNG2dAOmHqEkuRtKTMRc4x2ISbAzscBDB7VSEbv8nUvDMulA2rigK5K5sjZMwmoqcz/Bh3VtueVIJCGGMCz6GjyuYdUZCyzwqln7R6ny360Iy8bD3B3IKMbWNDvWXQmgH8PngA6KEhQ/+hbqqSZkNHhIvXGydFcezPS34ss1o6dFhTnDBo0WFIbm4kgSoed4OASKMM4ZzV8VDENv8CTmMKW/M5QzupUuc1udv7" Nov 26 14:52:09 volumio02 go-librespot[1415]: time="2024-11-26T14:52:09+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 26 14:52:09 volumio02 go-librespot[1415]: time="2024-11-26T14:52:09+01:00" level=debug msg="completed keyexchange" Nov 26 14:52:10 volumio02 mpd[1398]: Nov 26 14:52 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 26 14:52:10 volumio02 volumio[1182]: info: Preload queue cleared Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage01/library/Daft.Punk/Daft Punk - Random Access Memories (2013) Qobuz [ALAC 24-88]/01-12-Daft_Punk_feat_Panda_Bear-Doin_it_Right-SMR.m4a Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage01/library/Daft.Punk/Daft Punk - Random Access Memories (2013) Qobuz [ALAC 24-88]/01-08-Daft_Punk_feat_Pharrell_Williams-Get_Luc-SMR.m4a Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage01/library/Daft.Punk/Daft Punk - Random Access Memories (2013) Qobuz [ALAC 24-88]/01-03-Daft_Punk-Giorgio_by_Moroder-SMR.m4a Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage02/music/library/mixek/2022/202208/Nina Kraviz live from Ultra in Croatia-pjBUCdrKvP8.mp3 Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage01/library/mixek/am - Tony McGuinness from Above & Beyond - 4.5 hour deep livestream set - May 31, 2020 [@Anjunadeep]-9KEnqixDeR8.mp3 Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage01/library/mixek/Beatman and Ludmilla - Petofi MR2 - 2014_10.mp3 Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage01/library/mixek/Monolink live at Gaatafushi Island, in the Maldives for Cercle and W Hotels-_SvwdK_HibQ.mp3 Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage01/library/mixek/citymatine/CityMatiné Live 010 - Fiesta fin de verano - Captain Knuckles b2b Sobek.mp3 Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage01/library/mixek/am - Tony McGuinness from Above & Beyond - 4.5 hour deep livestream set - May 31, 2020 [@Anjunadeep]-9KEnqixDeR8.mp3 Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage01/library/mixek/citymatine/CityMatiné Live 011 - Fiesta Fin De Verano - Monolit.mp3 Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage01/library/mixek/Kollektiv Turmstrasse - MEOKO Exclusive Mix.m4a Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage01/library/mixek/20220710/Zvezda Beta @ Decameron livestream-Mo05WGrrLrE.mp3 Nov 26 14:52:10 volumio02 volumio[1182]: info: Preloading song: mnt/NAS/storage01/library/mixek/20220710/Zvezda Beta @ Decameron livestream-Mo05WGrrLrE.mp3 Nov 26 14:52:10 volumio02 go-librespot[1415]: time="2024-11-26T14:52:10+01:00" level=debug msg="completed challenge" Nov 26 14:52:10 volumio02 go-librespot[1415]: time="2024-11-26T14:52:10+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" Nov 26 14:52:10 volumio02 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 26 14:52:10 volumio02 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 26 14:52:10 volumio02 systemd[1]: Started Music Player Daemon. Nov 26 14:52:10 volumio02 sudo[1375]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:10 volumio02 sudo[1366]: pam_unix(sudo:session): session closed for user root Nov 26 14:52:10 volumio02 volumio[1182]: info: Exploding uri mnt/NAS/storage01/library/Daft.Punk/Daft Punk - Random Access Memories (2013) Qobuz [ALAC 24-88]/01-12-Daft_Punk_feat_Panda_Bear-Doin_it_Right-SMR.m4a in service mpd Nov 26 14:52:10 volumio02 volumio[1182]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 14:52:10 volumio02 volumio[1182]: TypeError: Cannot read property 'then' of undefined Nov 26 14:52:10 volumio02 volumio[1182]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2528:19) Nov 26 14:52:10 volumio02 volumio[1182]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2326:21) Nov 26 14:52:10 volumio02 volumio[1182]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1379:16) Nov 26 14:52:10 volumio02 volumio[1182]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Nov 26 14:52:10 volumio02 volumio[1182]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Nov 26 14:52:10 volumio02 volumio[1182]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100) Nov 26 14:52:10 volumio02 volumio[1182]: at listOnTimeout (internal/timers.js:554:17) Nov 26 14:52:10 volumio02 volumio[1182]: at processTimers (internal/timers.js:497:7) Nov 26 14:52:10 volumio02 volumio[1182]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 14:52:11 volumio02 sudo[1456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 14:51 Nov 26 14:52:11 volumio02 sudo[1456]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"