-- Logs begin at Thu 2024-05-02 04:45:44 UTC, end at Thu 2024-05-02 04:47:03 UTC. -- May 02 04:46:05 hi-fi-ultra networking[394]: dhcpcd[558]: eth0: leased 192.168.68.160 for 7200 seconds May 02 04:46:05 hi-fi-ultra dhcpcd[558]: eth0: leased 192.168.68.160 for 7200 seconds May 02 04:46:05 hi-fi-ultra networking[394]: dhcpcd[558]: eth0: adding host route to 192.168.68.160 via 127.0.0.1 May 02 04:46:05 hi-fi-ultra dhcpcd[558]: eth0: adding host route to 192.168.68.160 via 127.0.0.1 May 02 04:46:05 hi-fi-ultra dhcpcd[558]: eth0: adding route to 192.168.68.0/24 May 02 04:46:05 hi-fi-ultra dhcpcd[558]: eth0: adding default route via 192.168.68.1 May 02 04:46:05 hi-fi-ultra networking[394]: dhcpcd[558]: eth0: adding route to 192.168.68.0/24 May 02 04:46:05 hi-fi-ultra networking[394]: dhcpcd[558]: eth0: adding default route via 192.168.68.1 May 02 04:46:05 hi-fi-ultra dhcpcd[558]: forked to background, child pid 603 May 02 04:46:05 hi-fi-ultra networking[394]: dhcpcd[558]: forked to background, child pid 603 May 02 04:46:05 hi-fi-ultra networking[394]: done. May 02 04:46:05 hi-fi-ultra systemd[1]: Started LSB: Raise network interfaces.. May 02 04:46:05 hi-fi-ultra systemd[1]: Starting ifup for wlan0... May 02 04:46:05 hi-fi-ultra systemd[1]: Started ifup for wlan0. May 02 04:46:05 hi-fi-ultra systemd[1]: Starting ifup for eth0... May 02 04:46:05 hi-fi-ultra systemd[1]: Started ifup for eth0. May 02 04:46:05 hi-fi-ultra ifup[649]: /sbin/ifup: interface wlan0 already configured May 02 04:46:05 hi-fi-ultra ifup[651]: /sbin/ifup: interface eth0 already configured May 02 04:46:05 hi-fi-ultra systemd[1]: Starting Network. May 02 04:46:05 hi-fi-ultra systemd[1]: Reached target Network. May 02 04:46:05 hi-fi-ultra systemd[1]: Starting Network is Online. May 02 04:46:05 hi-fi-ultra systemd[1]: Reached target Network is Online. May 02 04:46:05 hi-fi-ultra systemd[1]: Starting LSB: RPC portmapper replacement... May 02 04:46:05 hi-fi-ultra rpcbind[653]: Starting rpcbind daemon.... May 02 04:46:05 hi-fi-ultra systemd[1]: Started LSB: RPC portmapper replacement. May 02 04:46:05 hi-fi-ultra systemd[1]: Starting RPC Port Mapper. May 02 04:46:05 hi-fi-ultra systemd[1]: Reached target RPC Port Mapper. May 02 04:46:05 hi-fi-ultra systemd[1]: Starting LSB: NFS support files common to client and server... May 02 04:46:06 hi-fi-ultra rpc.statd[674]: Version 1.2.8 starting May 02 04:46:06 hi-fi-ultra sm-notify[675]: Version 1.2.8 starting May 02 04:46:06 hi-fi-ultra kernel: Installing knfsd (copyright (C) 1996 okir@monad.swb.de). May 02 04:46:06 hi-fi-ultra nfs-common[668]: Starting NFS common utilities: statd idmapd. May 02 04:46:06 hi-fi-ultra systemd[1]: Started LSB: NFS support files common to client and server. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting System Initialization. May 02 04:46:06 hi-fi-ultra systemd[1]: Reached target System Initialization. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Avahi mDNS/DNS-SD Stack Activation Socket. May 02 04:46:06 hi-fi-ultra systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting mpd.socket. May 02 04:46:06 hi-fi-ultra systemd[1]: Listening on mpd.socket. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting D-Bus System Message Bus Socket. May 02 04:46:06 hi-fi-ultra systemd[1]: Listening on D-Bus System Message Bus Socket. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Sockets. May 02 04:46:06 hi-fi-ultra systemd[1]: Reached target Sockets. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Daily Cleanup of Temporary Directories. May 02 04:46:06 hi-fi-ultra systemd[1]: Started Daily Cleanup of Temporary Directories. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Timers. May 02 04:46:06 hi-fi-ultra systemd[1]: Reached target Timers. May 02 04:46:06 hi-fi-ultra systemd[1]: Started Manage Sound Card State (restore and store). May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Restore Sound Card State... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Basic System. May 02 04:46:06 hi-fi-ultra systemd[1]: Reached target Basic System. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Entropy daemon using the HAVEGE algorithm... May 02 04:46:06 hi-fi-ultra systemd[1]: Started Entropy daemon using the HAVEGE algorithm. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting cd.service... May 02 04:46:06 hi-fi-ultra systemd[1]: Started cd.service. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting dater.service... May 02 04:46:06 hi-fi-ultra systemd[1]: Started dater.service. May 02 04:46:06 hi-fi-ultra systemd[1]: Started Configure Bluetooth Modems connected by UART. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Bluetooth service... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Volumio Iptables Module... May 02 04:46:06 hi-fi-ultra systemd[1]: Started Volumio Iptables Module. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Priority Optimizer Service... May 02 04:46:06 hi-fi-ultra systemd[1]: Started Priority Optimizer Service. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting mount disks automatically with standby... May 02 04:46:06 hi-fi-ultra systemd[1]: Started mount disks automatically with standby. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting UPnP Renderer front-end to MPD... May 02 04:46:06 hi-fi-ultra systemd[1]: Started UPnP Renderer front-end to MPD. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting volumio-remote-updater.service... May 02 04:46:06 hi-fi-ultra systemd[1]: Started volumio-remote-updater.service. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Volumio Log Rotation Service... May 02 04:46:06 hi-fi-ultra systemd[1]: Started Volumio Log Rotation Service. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Volumio SSH enabler... May 02 04:46:06 hi-fi-ultra systemd[1]: Started Volumio SSH enabler. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Wireless Services... May 02 04:46:06 hi-fi-ultra alsactl[691]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 40 Validity:0' : Operation not permitted May 02 04:46:06 hi-fi-ultra volumio[693]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Xbindrc... May 02 04:46:06 hi-fi-ultra systemd[1]: Started Xbindrc. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting /etc/rc.local Compatibility... May 02 04:46:06 hi-fi-ultra systemd[1]: Started getty on tty2-tty6 if dbus and logind are not available. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Login Prompts. May 02 04:46:06 hi-fi-ultra systemd[1]: Reached target Login Prompts. May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Login Service... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting LSB: start Winbind daemon... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting LSB: triggerhappy hotkey daemon... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting LSB: start Samba daemons for the AD DC... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting LSB: Start NTP daemon... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting LSB: start Samba NetBIOS nameserver (nmbd)... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting LSB: Brings up/down network automatically... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting LSB: Advanced IEEE 802.11 management daemon... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting LSB: IPv4 DHCP client with IPv4LL support... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Avahi mDNS/DNS-SD Stack... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting Music Player Daemon... May 02 04:46:06 hi-fi-ultra systemd[1]: Starting D-Bus System Message Bus... May 02 04:46:06 hi-fi-ultra prio-optmimize[700]: 3 (process ID) old priority 0, new priority -10 May 02 04:46:06 hi-fi-ultra bluetoothd[695]: Bluetooth daemon 5.23 May 02 04:46:06 hi-fi-ultra prio-optmimize[700]: 12 (process ID) old priority 0, new priority -10 May 02 04:46:06 hi-fi-ultra systemd[1]: Started D-Bus System Message Bus. May 02 04:46:06 hi-fi-ultra prio-optmimize[700]: 16 (process ID) old priority -20, new priority -10 May 02 04:46:06 hi-fi-ultra prio-optmimize[700]: 20 (process ID) old priority 0, new priority -10 May 02 04:46:06 hi-fi-ultra dhcpcd[733]: Not running dhcpcd because there is aleady an interface specific instance ... failed! May 02 04:46:06 hi-fi-ultra dhcpcd[733]: /var/run/dhcpcd-eth0.pid ... failed! May 02 04:46:06 hi-fi-ultra triggerhappy[716]: Unable to parse trigger line: May 02 04:46:06 hi-fi-ultra triggerhappy[716]: Unable to parse trigger line: May 02 04:46:06 hi-fi-ultra triggerhappy[716]: Unable to parse trigger line: May 02 04:46:06 hi-fi-ultra triggerhappy[716]: Unable to parse trigger line: May 02 04:46:06 hi-fi-ultra triggerhappy[716]: Unable to parse trigger line: May 02 04:46:06 hi-fi-ultra triggerhappy[716]: Unable to parse trigger line: May 02 04:46:06 hi-fi-ultra triggerhappy[716]: Unable to parse trigger line: May 02 04:46:06 hi-fi-ultra triggerhappy[716]: Error opening '/dev/input/event*': No such file or directory May 02 04:46:06 hi-fi-ultra kernel: ip_tables: (C) 2000-2006 Netfilter Core Team May 02 04:46:06 hi-fi-ultra ifplugd(eth0)[815]: ifplugd 0.28 initializing. May 02 04:46:06 hi-fi-ultra ifplugd(eth0)[815]: Using interface eth0/B8:27:EB:48:4B:84 with driver (version: 22-Aug-2005) May 02 04:46:06 hi-fi-ultra ifplugd(eth0)[815]: Using detection mode: SIOCETHTOOL May 02 04:46:06 hi-fi-ultra ifplugd(eth0)[815]: Initialization complete, link beat detected. May 02 04:46:06 hi-fi-ultra prio-optmimize[700]: Renicing jbd2 (132) to 20 May 02 04:46:06 hi-fi-ultra prio-optmimize[700]: 132 (process ID) old priority 0, new priority 19 May 02 04:46:07 hi-fi-ultra prio-optmimize[700]: Renicing jbd2 (161) to 20 May 02 04:46:07 hi-fi-ultra prio-optmimize[700]: 161 (process ID) old priority 0, new priority 19 May 02 04:46:07 hi-fi-ultra loadcpufreq[722]: Loading cpufreq kernel modules...done (none). May 02 04:46:07 hi-fi-ultra prio-optmimize[700]: Renicing haveged (692) to 20 May 02 04:46:07 hi-fi-ultra prio-optmimize[700]: 692 (process ID) old priority 0, new priority 19 May 02 04:46:07 hi-fi-ultra ifplugd(eth0)[815]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. May 02 04:46:07 hi-fi-ultra ifplugd(eth0)[815]: client: /sbin/ifup: interface eth0 already configured May 02 04:46:07 hi-fi-ultra kernel: nf_conntrack version 0.5.0 (15360 buckets, 61440 max) May 02 04:46:07 hi-fi-ultra prio-optmimize[700]: Renicing upmpdcli (702) to 20 May 02 04:46:07 hi-fi-ultra prio-optmimize[700]: 702 (process ID) old priority 0, new priority 19 May 02 04:46:07 hi-fi-ultra ifplugd(eth0)[815]: Program executed successfully. May 02 04:46:07 hi-fi-ultra ifplugd[726]: Network Interface Plugging Daemon...start eth0...done. May 02 04:46:07 hi-fi-ultra prio-optmimize[700]: Renicing ifplugd (726) to 20 May 02 04:46:07 hi-fi-ultra prio-optmimize[700]: 726 (process ID) old priority 0, new priority 19 May 02 04:46:07 hi-fi-ultra prio-optmimize[700]: Renicing ifplugd (815) to 20 May 02 04:46:07 hi-fi-ultra prio-optmimize[700]: 815 (process ID) old priority 0, new priority 19 May 02 04:46:07 hi-fi-ultra sudo[730]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off May 02 04:46:07 hi-fi-ultra sudo[730]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:07 hi-fi-ultra ntpd[790]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1) May 02 04:46:07 hi-fi-ultra ntp[720]: Starting NTP server: ntpd. May 02 04:46:07 hi-fi-ultra sudo[730]: pam_unix(sudo:session): session closed for user root May 02 04:46:07 hi-fi-ultra ntpd[852]: proto: precision = 1.042 usec May 02 04:46:07 hi-fi-ultra ntpd[852]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 May 02 04:46:07 hi-fi-ultra ntpd[852]: Listen and drop on 1 v6wildcard :: UDP 123 May 02 04:46:07 hi-fi-ultra ntpd[852]: Listen normally on 2 lo 127.0.0.1 UDP 123 May 02 04:46:07 hi-fi-ultra ntpd[852]: Listen normally on 3 eth0 192.168.68.160 UDP 123 May 02 04:46:07 hi-fi-ultra ntpd[852]: peers refreshed May 02 04:46:07 hi-fi-ultra ntpd[852]: Listening on routing socket on fd #20 for interface updates May 02 04:46:07 hi-fi-ultra avahi-daemon[734]: Found user 'avahi' (UID 104) and group 'avahi' (GID 106). May 02 04:46:07 hi-fi-ultra avahi-daemon[734]: Successfully dropped root privileges. May 02 04:46:07 hi-fi-ultra avahi-daemon[734]: avahi-daemon 0.6.31 starting up. May 02 04:46:07 hi-fi-ultra bluetoothd[695]: Starting SDP server May 02 04:46:07 hi-fi-ultra systemd[1]: Started Avahi mDNS/DNS-SD Stack. May 02 04:46:07 hi-fi-ultra systemd[1]: Started Bluetooth service. May 02 04:46:07 hi-fi-ultra systemd[1]: Starting Bluetooth. May 02 04:46:07 hi-fi-ultra systemd[1]: Reached target Bluetooth. May 02 04:46:07 hi-fi-ultra systemd[1]: Starting Permit User Sessions... May 02 04:46:07 hi-fi-ultra systemd[1]: Started Restore Sound Card State. May 02 04:46:07 hi-fi-ultra systemd[1]: cd.service: main process exited, code=exited, status=127/n/a May 02 04:46:07 hi-fi-ultra avahi-daemon[734]: Successfully called chroot(). May 02 04:46:07 hi-fi-ultra avahi-daemon[734]: Successfully dropped remaining capabilities. May 02 04:46:07 hi-fi-ultra systemd[1]: Unit cd.service entered failed state. May 02 04:46:07 hi-fi-ultra avahi-daemon[734]: Loading service file /services/volumio.service. May 02 04:46:07 hi-fi-ultra avahi-daemon[734]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.68.160. May 02 04:46:07 hi-fi-ultra avahi-daemon[734]: New relevant interface eth0.IPv4 for mDNS. May 02 04:46:07 hi-fi-ultra avahi-daemon[734]: Network interface enumeration completed. May 02 04:46:07 hi-fi-ultra avahi-daemon[734]: Registering new address record for 192.168.68.160 on eth0.IPv4. May 02 04:46:07 hi-fi-ultra avahi-daemon[734]: Registering HINFO record with values 'ARMV7L'/'LINUX'. May 02 04:46:07 hi-fi-ultra systemd[1]: Started /etc/rc.local Compatibility. May 02 04:46:07 hi-fi-ultra systemd[1]: Started LSB: triggerhappy hotkey daemon. May 02 04:46:07 hi-fi-ultra systemd[1]: Started LSB: Start NTP daemon. May 02 04:46:07 hi-fi-ultra systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. May 02 04:46:07 hi-fi-ultra systemd[1]: Started LSB: Brings up/down network automatically. May 02 04:46:07 hi-fi-ultra systemd[1]: Started LSB: Advanced IEEE 802.11 management daemon. May 02 04:46:07 hi-fi-ultra systemd[1]: dhcpcd.service: control process exited, code=exited status=6 May 02 04:46:07 hi-fi-ultra dbus[739]: [system] Activating via systemd: service name='org.freedesktop.UDisks' unit='udisks.service' May 02 04:46:07 hi-fi-ultra systemd[1]: Failed to start LSB: IPv4 DHCP client with IPv4LL support. May 02 04:46:07 hi-fi-ultra systemd[1]: Unit dhcpcd.service entered failed state. May 02 04:46:07 hi-fi-ultra systemd[1]: Started Permit User Sessions. May 02 04:46:07 hi-fi-ultra systemd[1]: cd.service holdoff time over, scheduling restart. May 02 04:46:07 hi-fi-ultra volumio-remote-updater[704]: Error: No active session May 02 04:46:07 hi-fi-ultra volumio-remote-updater[704]: [2024-05-02 04:46:07] [info] asio async_connect error: system:111 (Connection refused) May 02 04:46:07 hi-fi-ultra volumio-remote-updater[704]: [2024-05-02 04:46:07] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 02 04:46:07 hi-fi-ultra volumio-remote-updater[704]: [2024-05-02 04:46:07] [error] handle_connect error: Underlying Transport Error May 02 04:46:07 hi-fi-ultra kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 May 02 04:46:07 hi-fi-ultra kernel: Bluetooth: BNEP filters: protocol multicast May 02 04:46:07 hi-fi-ultra kernel: Bluetooth: BNEP socket layer initialized May 02 04:46:07 hi-fi-ultra bluetoothd[695]: Bluetooth management interface 1.14 initialized May 02 04:46:07 hi-fi-ultra dbus[739]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' May 02 04:46:07 hi-fi-ultra bluetoothd[695]: Sap driver initialization failed. May 02 04:46:07 hi-fi-ultra bluetoothd[695]: sap-server: Operation not permitted (1) May 02 04:46:08 hi-fi-ultra bluetoothd[695]: GAP and GATT are mandatory May 02 04:46:08 hi-fi-ultra bluetoothd[695]: gap-gatt-profile profile probe failed for B0:CA:68:80:2F:CA May 02 04:46:08 hi-fi-ultra systemd-logind[714]: New seat seat0. May 02 04:46:08 hi-fi-ultra systemd[1]: Started Login Service. May 02 04:46:08 hi-fi-ultra systemd[1]: Starting Hostname Service... May 02 04:46:08 hi-fi-ultra systemd[1]: Starting Disk Manager (legacy version)... May 02 04:46:08 hi-fi-ultra systemd[1]: Stopping cd.service... May 02 04:46:08 hi-fi-ultra systemd[1]: Starting cd.service... May 02 04:46:08 hi-fi-ultra systemd[1]: Started cd.service. May 02 04:46:08 hi-fi-ultra systemd[1]: Starting LSB: set CPUFreq kernel parameters... May 02 04:46:08 hi-fi-ultra systemd[1]: Starting Hold until boot process finishes up... May 02 04:46:08 hi-fi-ultra systemd[1]: Starting Terminate Plymouth Boot Screen... May 02 04:46:08 hi-fi-ultra volumio[869]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory May 02 04:46:08 hi-fi-ultra volumio[702]: Could not open config: /tmp/upmpdcli.conf May 02 04:46:08 hi-fi-ultra dbus[739]: [system] Successfully activated service 'org.freedesktop.UDisks' May 02 04:46:08 hi-fi-ultra cpufrequtils[870]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. May 02 04:46:08 hi-fi-ultra systemd-hostnamed[867]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname! May 02 04:46:08 hi-fi-ultra dbus[739]: [system] Successfully activated service 'org.freedesktop.hostname1' May 02 04:46:08 hi-fi-ultra systemd[1]: Received SIGRTMIN+21 from PID 265 (plymouthd). May 02 04:46:08 hi-fi-ultra systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE May 02 04:46:08 hi-fi-ultra systemd[1]: Unit upmpdcli.service entered failed state. May 02 04:46:08 hi-fi-ultra systemd[1]: cd.service: main process exited, code=exited, status=127/n/a May 02 04:46:08 hi-fi-ultra systemd[1]: Unit cd.service entered failed state. May 02 04:46:08 hi-fi-ultra systemd[1]: Started LSB: set CPUFreq kernel parameters. May 02 04:46:08 hi-fi-ultra systemd[1]: Started Hold until boot process finishes up. May 02 04:46:08 hi-fi-ultra systemd[1]: Started Terminate Plymouth Boot Screen. May 02 04:46:08 hi-fi-ultra systemd[1]: Started Disk Manager (legacy version). May 02 04:46:08 hi-fi-ultra systemd[1]: Started Hostname Service. May 02 04:46:08 hi-fi-ultra dbus[739]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' May 02 04:46:08 hi-fi-ultra systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks... May 02 04:46:08 hi-fi-ultra avahi-daemon[734]: Server startup complete. Host name is hi-fi-ultra.local. Local service cookie is 513854180. May 02 04:46:08 hi-fi-ultra systemd[1]: cd.service holdoff time over, scheduling restart. May 02 04:46:08 hi-fi-ultra systemd[1]: Stopping cd.service... May 02 04:46:08 hi-fi-ultra systemd[1]: Starting cd.service... May 02 04:46:08 hi-fi-ultra systemd[1]: Started cd.service. May 02 04:46:08 hi-fi-ultra volumio[895]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory May 02 04:46:08 hi-fi-ultra systemd[1]: cd.service: main process exited, code=exited, status=127/n/a May 02 04:46:08 hi-fi-ultra systemd[1]: Unit cd.service entered failed state. May 02 04:46:08 hi-fi-ultra polkitd[892]: started daemon version 0.105 using authority implementation `local' version `0.105' May 02 04:46:08 hi-fi-ultra dbus[739]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' May 02 04:46:08 hi-fi-ultra systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks. May 02 04:46:08 hi-fi-ultra systemd[1]: cd.service holdoff time over, scheduling restart. May 02 04:46:08 hi-fi-ultra systemd[1]: Stopping cd.service... May 02 04:46:08 hi-fi-ultra systemd[1]: Starting cd.service... May 02 04:46:08 hi-fi-ultra systemd[1]: Started cd.service. May 02 04:46:08 hi-fi-ultra volumio[901]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory May 02 04:46:08 hi-fi-ultra systemd[1]: cd.service: main process exited, code=exited, status=127/n/a May 02 04:46:08 hi-fi-ultra systemd[1]: Unit cd.service entered failed state. May 02 04:46:09 hi-fi-ultra haveged[692]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K May 02 04:46:09 hi-fi-ultra haveged[692]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 8/40; sz: 15248/74244 May 02 04:46:09 hi-fi-ultra haveged[692]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00286 May 02 04:46:09 hi-fi-ultra haveged[692]: haveged: fills: 0, generated: 0 May 02 04:46:09 hi-fi-ultra udisks-glue[701]: Device file /dev/mmcblk0p3 inserted May 02 04:46:09 hi-fi-ultra udisks-glue[701]: Device file /dev/mmcblk0 inserted May 02 04:46:09 hi-fi-ultra systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 02 04:46:09 hi-fi-ultra systemd[1]: cd.service holdoff time over, scheduling restart. May 02 04:46:09 hi-fi-ultra systemd[1]: Stopping cd.service... May 02 04:46:09 hi-fi-ultra systemd[1]: Starting cd.service... May 02 04:46:09 hi-fi-ultra systemd[1]: Started cd.service. May 02 04:46:09 hi-fi-ultra systemd[1]: Stopping Xbindrc... May 02 04:46:09 hi-fi-ultra systemd[1]: Starting Xbindrc... May 02 04:46:09 hi-fi-ultra systemd[1]: Started Xbindrc. May 02 04:46:09 hi-fi-ultra systemd[1]: cd.service: main process exited, code=exited, status=127/n/a May 02 04:46:09 hi-fi-ultra udisks-glue[701]: Device file /dev/mmcblk0rpmb inserted May 02 04:46:09 hi-fi-ultra systemd[1]: Unit cd.service entered failed state. May 02 04:46:09 hi-fi-ultra volumio[903]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory May 02 04:46:09 hi-fi-ultra udisks-glue[701]: Device file /dev/mmcblk0boot0 inserted May 02 04:46:09 hi-fi-ultra udisks-glue[701]: Device file /dev/mmcblk0boot1 inserted May 02 04:46:09 hi-fi-ultra systemd[1]: cd.service holdoff time over, scheduling restart. May 02 04:46:09 hi-fi-ultra systemd[1]: Stopping cd.service... May 02 04:46:09 hi-fi-ultra systemd[1]: Starting cd.service... May 02 04:46:09 hi-fi-ultra systemd[1]: cd.service start request repeated too quickly, refusing to start. May 02 04:46:09 hi-fi-ultra systemd[1]: Failed to start cd.service. May 02 04:46:09 hi-fi-ultra systemd[1]: Unit cd.service entered failed state. May 02 04:46:09 hi-fi-ultra avahi-daemon[734]: Service "Hi-Fi Ultra" (/services/volumio.service) successfully established. May 02 04:46:09 hi-fi-ultra systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 02 04:46:09 hi-fi-ultra systemd[1]: Stopping Xbindrc... May 02 04:46:09 hi-fi-ultra systemd[1]: Starting Xbindrc... May 02 04:46:09 hi-fi-ultra systemd[1]: Started Xbindrc. May 02 04:46:10 hi-fi-ultra systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 02 04:46:10 hi-fi-ultra systemd[1]: Stopping Xbindrc... May 02 04:46:10 hi-fi-ultra systemd[1]: Starting Xbindrc... May 02 04:46:10 hi-fi-ultra systemd[1]: Started Xbindrc. May 02 04:46:10 hi-fi-ultra systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 02 04:46:10 hi-fi-ultra systemd[1]: Stopping Xbindrc... May 02 04:46:10 hi-fi-ultra systemd[1]: Starting Xbindrc... May 02 04:46:10 hi-fi-ultra systemd[1]: Started Xbindrc. May 02 04:46:11 hi-fi-ultra wireless.js[863]: Cleaning previous... May 02 04:46:11 hi-fi-ultra systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 02 04:46:11 hi-fi-ultra systemd[1]: Stopping Xbindrc... May 02 04:46:11 hi-fi-ultra systemd[1]: Starting Xbindrc... May 02 04:46:11 hi-fi-ultra systemd[1]: xbindkeysrc.service start request repeated too quickly, refusing to start. May 02 04:46:11 hi-fi-ultra systemd[1]: Failed to start Xbindrc. May 02 04:46:11 hi-fi-ultra systemd[1]: Unit xbindkeysrc.service entered failed state. May 02 04:46:11 hi-fi-ultra systemd[1]: Stopped hotspot.service. May 02 04:46:11 hi-fi-ultra systemd[1]: Started Music Player Daemon. May 02 04:46:11 hi-fi-ultra sudo[943]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 02 04:46:11 hi-fi-ultra sudo[943]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:11 hi-fi-ultra sudo[943]: pam_unix(sudo:session): session closed for user root May 02 04:46:11 hi-fi-ultra sudo[951]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 02 04:46:11 hi-fi-ultra sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:11 hi-fi-ultra sudo[951]: pam_unix(sudo:session): session closed for user root May 02 04:46:11 hi-fi-ultra wireless.js[863]: Stopped aP May 02 04:46:11 hi-fi-ultra wireless.js[863]: Wireless Networking DISABLED, not starting wireless flow May 02 04:46:11 hi-fi-ultra systemd[1]: Started Wireless Services. May 02 04:46:11 hi-fi-ultra systemd[1]: Starting Volumio Backend Module... May 02 04:46:11 hi-fi-ultra systemd[1]: Started Volumio Backend Module. May 02 04:46:11 hi-fi-ultra systemd[1]: Starting Start Volumio Kiosk... May 02 04:46:11 hi-fi-ultra systemd[1]: Started Start Volumio Kiosk. May 02 04:46:11 hi-fi-ultra systemd[1]: Starting Volumio Streaming Daemon... May 02 04:46:11 hi-fi-ultra systemd[1]: Started Volumio Streaming Daemon. May 02 04:46:11 hi-fi-ultra systemd[1]: Started LSB: start Samba daemons for the AD DC. May 02 04:46:11 hi-fi-ultra volumio-streaming-daemon[965]: ############################ May 02 04:46:11 hi-fi-ultra volumio-streaming-daemon[965]: # Volumio Streaming Daemon # May 02 04:46:11 hi-fi-ultra volumio-streaming-daemon[965]: # Running on port 7777 # May 02 04:46:11 hi-fi-ultra volumio-streaming-daemon[965]: ############################ May 02 04:46:11 hi-fi-ultra volumio-streaming-daemon[965]: Checking variant in static cache May 02 04:46:11 hi-fi-ultra volumio-streaming-daemon[965]: Enabled services: May 02 04:46:11 hi-fi-ultra volumio-streaming-daemon[965]: 1) tidal May 02 04:46:11 hi-fi-ultra volumio-streaming-daemon[965]: 2) qobuz May 02 04:46:11 hi-fi-ultra startx[964]: X.Org X Server 1.18.4 May 02 04:46:11 hi-fi-ultra startx[964]: Release Date: 2016-07-19 May 02 04:46:11 hi-fi-ultra startx[964]: X Protocol Version 11, Revision 0 May 02 04:46:11 hi-fi-ultra startx[964]: Build Operating System: Linux 4.4.26-v7+ armv7l Raspbian May 02 04:46:11 hi-fi-ultra startx[964]: Current Operating System: Linux hi-fi-ultra 4.9.65-v7+ #1 SMP Thu Jul 19 18:43:14 UTC 2018 armv7l May 02 04:46:11 hi-fi-ultra startx[964]: Kernel command line: bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=B8:27:EB:48:4B:84 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash quiet 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=2 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh elevator=noop rootwait smsc95xx.turbo_mode=N bootdelay=5 logo.nologo vt.global_cursor_default=0 loglevel=0 consoleblank=0 May 02 04:46:11 hi-fi-ultra startx[964]: Build Date: 11 November 2016 11:59:59AM May 02 04:46:11 hi-fi-ultra startx[964]: xorg-server 2:1.18.4-2+rpi1 (https://www.debian.org/support) May 02 04:46:11 hi-fi-ultra startx[964]: Current version of pixman: 0.32.6 May 02 04:46:11 hi-fi-ultra startx[964]: Before reporting problems, check http://wiki.x.org May 02 04:46:11 hi-fi-ultra startx[964]: to make sure that you have the latest version. May 02 04:46:11 hi-fi-ultra startx[964]: Markers: (--) probed, (**) from config file, (==) default setting, May 02 04:46:11 hi-fi-ultra startx[964]: (++) from command line, (!!) notice, (II) informational, May 02 04:46:11 hi-fi-ultra startx[964]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. May 02 04:46:11 hi-fi-ultra startx[964]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu May 2 04:46:11 2024 May 02 04:46:11 hi-fi-ultra startx[964]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" May 02 04:46:11 hi-fi-ultra winbind[715]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory May 02 04:46:11 hi-fi-ultra winbind[715]: Failed to create /var/log/samba/cores for user 0 with mode 0700 May 02 04:46:11 hi-fi-ultra winbind[715]: Unable to setup corepath for winbindd: No such file or directory May 02 04:46:11 hi-fi-ultra winbind[715]: mkdir failed on directory /var/log/samba/cores: No such file or directory May 02 04:46:11 hi-fi-ultra winbind[715]: Failed to create /var/log/samba/cores for user 0 with mode 0700 May 02 04:46:11 hi-fi-ultra winbind[715]: Unable to setup corepath for winbindd: No such file or directory May 02 04:46:11 hi-fi-ultra winbind[715]: [2024/05/02 04:46:11, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:11 hi-fi-ultra winbind[715]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory May 02 04:46:11 hi-fi-ultra winbind[715]: [2024/05/02 04:46:11, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:11 hi-fi-ultra winbind[715]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory May 02 04:46:11 hi-fi-ultra winbind[715]: [2024/05/02 04:46:11, 0] ../source3/winbindd/winbindd.c:1549(main) May 02 04:46:11 hi-fi-ultra winbind[715]: winbindd version 4.2.14-Debian started. May 02 04:46:11 hi-fi-ultra winbind[715]: Copyright Andrew Tridgell and the Samba Team 1992-2014 May 02 04:46:11 hi-fi-ultra winbind[715]: [2024/05/02 04:46:11, 0] ../lib/util/util.c:220(directory_create_or_exist) May 02 04:46:11 hi-fi-ultra winbind[715]: mkdir failed on directory /var/log/samba/cores: No such file or directory May 02 04:46:11 hi-fi-ultra winbind[715]: [2024/05/02 04:46:11, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) May 02 04:46:11 hi-fi-ultra winbind[715]: Failed to create /var/log/samba/cores for user 0 with mode 0700 May 02 04:46:11 hi-fi-ultra winbind[715]: [2024/05/02 04:46:11, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) May 02 04:46:11 hi-fi-ultra winbind[715]: Unable to setup corepath for winbindd: No such file or directory May 02 04:46:11 hi-fi-ultra nmbd[721]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory May 02 04:46:11 hi-fi-ultra nmbd[721]: Failed to create /var/log/samba/cores for user 0 with mode 0700 May 02 04:46:11 hi-fi-ultra nmbd[721]: Unable to setup corepath for nmbd: No such file or directory May 02 04:46:11 hi-fi-ultra nmbd[1009]: [2024/05/02 04:46:11.925061, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:11 hi-fi-ultra nmbd[1009]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory May 02 04:46:11 hi-fi-ultra winbindd[1005]: [2024/05/02 04:46:11.926847, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:11 hi-fi-ultra winbindd[1005]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory May 02 04:46:11 hi-fi-ultra nmbd[1009]: [2024/05/02 04:46:11.927542, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:11 hi-fi-ultra nmbd[1009]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory May 02 04:46:11 hi-fi-ultra winbindd[1005]: [2024/05/02 04:46:11.927759, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:11 hi-fi-ultra winbindd[1005]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory May 02 04:46:11 hi-fi-ultra nmbd[1010]: [2024/05/02 04:46:11.931123, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) May 02 04:46:11 hi-fi-ultra nmbd[1010]: started asyncdns process 1011 May 02 04:46:11 hi-fi-ultra nmbd[1010]: [2024/05/02 04:46:11.939768, 0] ../lib/util/become_daemon.c:124(daemon_ready) May 02 04:46:11 hi-fi-ultra nmbd[1010]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 02 04:46:11 hi-fi-ultra systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). May 02 04:46:11 hi-fi-ultra systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... May 02 04:46:11 hi-fi-ultra nmbd[721]: [2024/05/02 04:46:11, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:11 hi-fi-ultra nmbd[721]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory May 02 04:46:11 hi-fi-ultra nmbd[721]: [2024/05/02 04:46:11, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:11 hi-fi-ultra nmbd[721]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory May 02 04:46:11 hi-fi-ultra nmbd[721]: [2024/05/02 04:46:11, 0] ../source3/nmbd/nmbd.c:908(main) May 02 04:46:11 hi-fi-ultra nmbd[721]: nmbd version 4.2.14-Debian started. May 02 04:46:11 hi-fi-ultra nmbd[721]: Copyright Andrew Tridgell and the Samba Team 1992-2014 May 02 04:46:11 hi-fi-ultra nmbd[721]: [2024/05/02 04:46:11.925061, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:11 hi-fi-ultra nmbd[721]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory May 02 04:46:11 hi-fi-ultra nmbd[721]: [2024/05/02 04:46:11.927542, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:11 hi-fi-ultra nmbd[721]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory May 02 04:46:11 hi-fi-ultra winbind[715]: [2024/05/02 04:46:11.926847, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:11 hi-fi-ultra winbind[715]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory May 02 04:46:11 hi-fi-ultra winbind[715]: [2024/05/02 04:46:11.927759, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:11 hi-fi-ultra winbind[715]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory May 02 04:46:11 hi-fi-ultra nmbd[721]: . May 02 04:46:11 hi-fi-ultra winbindd[1019]: [2024/05/02 04:46:11.976585, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) May 02 04:46:11 hi-fi-ultra winbindd[1019]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 02 04:46:11 hi-fi-ultra systemd[1]: Started LSB: start Winbind daemon. May 02 04:46:11 hi-fi-ultra winbind[715]: . May 02 04:46:12 hi-fi-ultra winbindd[1019]: [2024/05/02 04:46:12.045424, 0] ../lib/util/become_daemon.c:124(daemon_ready) May 02 04:46:12 hi-fi-ultra winbindd[1019]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 02 04:46:12 hi-fi-ultra winbindd[1020]: [2024/05/02 04:46:12.051097, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:12 hi-fi-ultra winbindd[1020]: Unable to open new log file '/var/log/samba/log.wb-HI-FI-ULTRA': No such file or directory May 02 04:46:12 hi-fi-ultra startx[964]: modprobe: FATAL: Module g2d_23 not found. May 02 04:46:12 hi-fi-ultra smbd[1012]: Starting SMB/CIFS daemon: smbd[2024/05/02 04:46:12, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:12 hi-fi-ultra smbd[1012]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 02 04:46:12 hi-fi-ultra smbd[1012]: [2024/05/02 04:46:12, 0] ../lib/util/util.c:220(directory_create_or_exist) May 02 04:46:12 hi-fi-ultra smbd[1012]: mkdir failed on directory /var/log/samba/cores: No such file or directory May 02 04:46:12 hi-fi-ultra smbd[1012]: [2024/05/02 04:46:12, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) May 02 04:46:12 hi-fi-ultra smbd[1012]: Failed to create /var/log/samba/cores for user 0 with mode 0700 May 02 04:46:12 hi-fi-ultra smbd[1012]: [2024/05/02 04:46:12, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) May 02 04:46:12 hi-fi-ultra smbd[1012]: Unable to setup corepath for smbd: No such file or directory May 02 04:46:12 hi-fi-ultra smbd[1012]: [2024/05/02 04:46:12, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:12 hi-fi-ultra smbd[1012]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 02 04:46:12 hi-fi-ultra smbd[1012]: [2024/05/02 04:46:12, 0] ../source3/smbd/server.c:1241(main) May 02 04:46:12 hi-fi-ultra smbd[1012]: smbd version 4.2.14-Debian started. May 02 04:46:12 hi-fi-ultra smbd[1012]: Copyright Andrew Tridgell and the Samba Team 1992-2014 May 02 04:46:12 hi-fi-ultra volumio-remote-updater[704]: [2024-05-02 04:46:12] [info] asio async_connect error: system:111 (Connection refused) May 02 04:46:12 hi-fi-ultra volumio-remote-updater[704]: [2024-05-02 04:46:12] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 02 04:46:12 hi-fi-ultra volumio-remote-updater[704]: [2024-05-02 04:46:12] [error] handle_connect error: Underlying Transport Error May 02 04:46:12 hi-fi-ultra smbd[1025]: [2024/05/02 04:46:12.970129, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:12 hi-fi-ultra smbd[1025]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 02 04:46:12 hi-fi-ultra smbd[1025]: [2024/05/02 04:46:12.971827, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:12 hi-fi-ultra smbd[1025]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 02 04:46:12 hi-fi-ultra smbd[1025]: [2024/05/02 04:46:12.972010, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:12 hi-fi-ultra smbd[1025]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 02 04:46:12 hi-fi-ultra smbd[1012]: [2024/05/02 04:46:12.970129, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:12 hi-fi-ultra smbd[1012]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 02 04:46:12 hi-fi-ultra smbd[1012]: [2024/05/02 04:46:12.971827, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:12 hi-fi-ultra smbd[1012]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 02 04:46:12 hi-fi-ultra smbd[1012]: [2024/05/02 04:46:12.972010, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:12 hi-fi-ultra smbd[1012]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 02 04:46:12 hi-fi-ultra smbd[1012]: . May 02 04:46:12 hi-fi-ultra systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). May 02 04:46:12 hi-fi-ultra systemd[1]: Starting Multi-User System. May 02 04:46:12 hi-fi-ultra systemd[1]: Reached target Multi-User System. May 02 04:46:12 hi-fi-ultra systemd[1]: Starting Graphical Interface. May 02 04:46:12 hi-fi-ultra systemd[1]: Reached target Graphical Interface. May 02 04:46:12 hi-fi-ultra systemd[1]: Starting Update UTMP about System Runlevel Changes... May 02 04:46:13 hi-fi-ultra systemd[1]: Started Update UTMP about System Runlevel Changes. May 02 04:46:13 hi-fi-ultra systemd[1]: Startup finished in 9.835s (kernel) + 29.694s (userspace) = 39.529s. May 02 04:46:13 hi-fi-ultra winbindd[1032]: [2024/05/02 04:46:13.051370, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:13 hi-fi-ultra winbindd[1032]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory May 02 04:46:13 hi-fi-ultra winbindd[1033]: [2024/05/02 04:46:13.114839, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:13 hi-fi-ultra winbindd[1033]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory May 02 04:46:13 hi-fi-ultra smbd[1026]: [2024/05/02 04:46:13.172379, 0] ../lib/util/become_daemon.c:124(daemon_ready) May 02 04:46:13 hi-fi-ultra smbd[1026]: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 02 04:46:13 hi-fi-ultra smbd[1034]: [2024/05/02 04:46:13.178365, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 02 04:46:13 hi-fi-ultra smbd[1034]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 02 04:46:15 hi-fi-ultra volumio[963]: info: ------------------------------------------- May 02 04:46:15 hi-fi-ultra volumio[963]: info: ----- Volumio2 ---- May 02 04:46:15 hi-fi-ultra volumio[963]: info: ------------------------------------------- May 02 04:46:15 hi-fi-ultra volumio[963]: info: ----- System startup ---- May 02 04:46:15 hi-fi-ultra volumio[963]: info: ------------------------------------------- May 02 04:46:16 hi-fi-ultra volumio[963]: info: Found new core plugin music_service/hi_res_audio. Adding it May 02 04:46:16 hi-fi-ultra volumio[963]: info: Found new core plugin music_service/qobuz. Adding it May 02 04:46:16 hi-fi-ultra volumio[963]: info: Found new core plugin miscellanea/metavolumio. Adding it May 02 04:46:16 hi-fi-ultra volumio[963]: info: Plugin folders cleanup May 02 04:46:16 hi-fi-ultra volumio[963]: info: Scanning into folder /volumio/app/plugins/ May 02 04:46:16 hi-fi-ultra volumio[963]: info: Scanning category audio_interface May 02 04:46:16 hi-fi-ultra volumio[963]: info: Scanning category miscellanea May 02 04:46:16 hi-fi-ultra volumio[963]: info: Scanning category music_service May 02 04:46:16 hi-fi-ultra volumio[963]: info: Scanning category plugins.json May 02 04:46:16 hi-fi-ultra volumio[963]: info: Scanning category system_controller May 02 04:46:16 hi-fi-ultra volumio[963]: info: Scanning category user_interface May 02 04:46:16 hi-fi-ultra volumio[963]: info: Scanning into folder /data/plugins/ May 02 04:46:16 hi-fi-ultra volumio[963]: info: Plugin folders cleanup completed May 02 04:46:16 hi-fi-ultra volumio[963]: info: ------------------------------------------- May 02 04:46:16 hi-fi-ultra volumio[963]: info: ----- Core plugins startup ---- May 02 04:46:16 hi-fi-ultra volumio[963]: info: ------------------------------------------- May 02 04:46:16 hi-fi-ultra volumio[963]: info: Loading plugins from folder /volumio/app/plugins/ May 02 04:46:16 hi-fi-ultra volumio[963]: info: Adding plugin upnp to MyMusic Plugins May 02 04:46:16 hi-fi-ultra volumio[963]: info: Adding plugin metavolumio to MyMusic Plugins May 02 04:46:16 hi-fi-ultra volumio[963]: info: Adding plugin airplay_emulation to MyMusic Plugins May 02 04:46:16 hi-fi-ultra volumio[963]: info: Adding plugin cd_controller to MyMusic Plugins May 02 04:46:16 hi-fi-ultra volumio[963]: info: Adding plugin raat to MyMusic Plugins May 02 04:46:16 hi-fi-ultra volumio[963]: info: Adding plugin upnp_browser to MyMusic Plugins May 02 04:46:16 hi-fi-ultra volumio[963]: info: Loading plugins from folder /data/plugins/ May 02 04:46:16 hi-fi-ultra volumio[963]: info: Loading plugin "system"... May 02 04:46:16 hi-fi-ultra volumio[963]: info: Applying required configuration parameters for plugin system May 02 04:46:16 hi-fi-ultra volumio[963]: info: Loading plugin "appearance"... May 02 04:46:17 hi-fi-ultra volumio[963]: info: Loading plugin "network"... May 02 04:46:18 hi-fi-ultra volumio[963]: info: Refreshing Cached IP Addresses May 02 04:46:18 hi-fi-ultra sudo[1086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 02 04:46:18 hi-fi-ultra volumio[963]: info: Loading plugin "services"... May 02 04:46:18 hi-fi-ultra sudo[1086]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:18 hi-fi-ultra volumio[963]: info: Loading plugin "alsa_controller"... May 02 04:46:18 hi-fi-ultra sudo[1086]: pam_unix(sudo:session): session closed for user root May 02 04:46:18 hi-fi-ultra sudo[1089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 02 04:46:18 hi-fi-ultra sudo[1089]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:18 hi-fi-ultra volumio[963]: info: Applying required configuration parameters for plugin alsa_controller May 02 04:46:18 hi-fi-ultra sudo[1089]: pam_unix(sudo:session): session closed for user root May 02 04:46:18 hi-fi-ultra volumio[963]: info: Loading plugin "wizard"... May 02 04:46:18 hi-fi-ultra volumio[963]: info: Loading plugin "volumio_command_line_client"... May 02 04:46:18 hi-fi-ultra volumio[963]: info: Loading plugin "upnp"... May 02 04:46:18 hi-fi-ultra volumio[963]: info: [1714625178256] Starting Upmpd Daemon May 02 04:46:18 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 02 04:46:18 hi-fi-ultra volumio[963]: info: Loading plugin "my_music"... May 02 04:46:18 hi-fi-ultra volumio[963]: info: Loading plugin "mpd"... May 02 04:46:18 hi-fi-ultra volumio[963]: info: Loading plugin "upnp_browser"... May 02 04:46:19 hi-fi-ultra volumio[963]: info: Loading plugin "networkfs"... May 02 04:46:19 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 02 04:46:19 hi-fi-ultra volumio[963]: info: Loading plugin "bluetooth"... May 02 04:46:19 hi-fi-ultra volumio[963]: info: [1714625179892] Starting BluetoothController May 02 04:46:19 hi-fi-ultra volumio[963]: info: Loading plugin "multiroom"... May 02 04:46:19 hi-fi-ultra volumio[963]: info: Loading plugin "alarm-clock"... May 02 04:46:20 hi-fi-ultra volumio[963]: info: Loading plugin "metavolumio"... May 02 04:46:20 hi-fi-ultra volumio-remote-updater[704]: [2024-05-02 04:46:20] [connect] Successful connection May 02 04:46:20 hi-fi-ultra volumio[963]: info: Loading plugin "airplay_emulation"... May 02 04:46:20 hi-fi-ultra volumio[963]: info: Starting Shairport Sync May 02 04:46:20 hi-fi-ultra volumio[963]: info: Loading plugin "cd_controller"... May 02 04:46:20 hi-fi-ultra sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync May 02 04:46:20 hi-fi-ultra sudo[1125]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:20 hi-fi-ultra systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 02 04:46:20 hi-fi-ultra sudo[1125]: pam_unix(sudo:session): session closed for user root May 02 04:46:20 hi-fi-ultra volumio[963]: info: Plugin last_100 is not enabled May 02 04:46:20 hi-fi-ultra volumio[963]: info: Plugin raat is not enabled May 02 04:46:20 hi-fi-ultra volumio[963]: info: Loading plugin "streaming_services"... May 02 04:46:20 hi-fi-ultra volumio[963]: info: Loading plugin "webradio"... May 02 04:46:21 hi-fi-ultra volumio[963]: info: Loading plugin "i2s_dacs"... May 02 04:46:21 hi-fi-ultra volumio[963]: info: I2S DAC not set, start Auto-detection May 02 04:46:21 hi-fi-ultra volumio[963]: info: Loading plugin "volumiodiscovery"... May 02 04:46:21 hi-fi-ultra volumio[963]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 02 04:46:21 hi-fi-ultra node[963]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 02 04:46:21 hi-fi-ultra node[963]: *** WARNING *** Please fix your application to use the native API of Avahi! May 02 04:46:21 hi-fi-ultra node[963]: *** WARNING *** For more information see May 02 04:46:21 hi-fi-ultra node[963]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 02 04:46:21 hi-fi-ultra node[963]: *** WARNING *** Please fix your application to use the native API of Avahi! May 02 04:46:21 hi-fi-ultra node[963]: *** WARNING *** For more information see May 02 04:46:21 hi-fi-ultra volumio[963]: *** WARNING *** Please fix your application to use the native API of Avahi! May 02 04:46:21 hi-fi-ultra volumio[963]: *** WARNING *** For more information see May 02 04:46:21 hi-fi-ultra volumio[963]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 02 04:46:21 hi-fi-ultra volumio[963]: *** WARNING *** Please fix your application to use the native API of Avahi! May 02 04:46:21 hi-fi-ultra volumio[963]: *** WARNING *** For more information see May 02 04:46:21 hi-fi-ultra volumio[963]: info: Applying required configuration parameters for plugin volumiodiscovery May 02 04:46:21 hi-fi-ultra volumio[963]: Discovery: StartAdv! undefined May 02 04:46:21 hi-fi-ultra volumio[963]: Discovery: Started advertising... hi-fi-ultra - undefined May 02 04:46:21 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 02 04:46:21 hi-fi-ultra volumio[963]: info: Plugin outputs is not enabled May 02 04:46:21 hi-fi-ultra volumio[963]: info: Loading plugin "albumart"... May 02 04:46:21 hi-fi-ultra volumio[963]: info: Plugin example_plugin is not enabled May 02 04:46:21 hi-fi-ultra volumio[963]: info: Loading plugin "hi_res_audio"... May 02 04:46:21 hi-fi-ultra volumio[963]: info: Loading plugin "inputs"... May 02 04:46:21 hi-fi-ultra volumio[963]: Forking 3 albumart workers May 02 04:46:21 hi-fi-ultra volumio[963]: info: Adding inputs REST Endpoints May 02 04:46:21 hi-fi-ultra volumio[963]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/inputs May 02 04:46:21 hi-fi-ultra volumio[963]: info: Scanning Audio Inputs May 02 04:46:21 hi-fi-ultra volumio[963]: info: Checking against Known Cards name May 02 04:46:21 hi-fi-ultra volumio[963]: info: Loading plugin "qobuz"... May 02 04:46:22 hi-fi-ultra volumio[963]: Starting albumart workers May 02 04:46:22 hi-fi-ultra volumio[963]: Starting albumart workers May 02 04:46:22 hi-fi-ultra volumio[963]: Starting albumart workers May 02 04:46:24 hi-fi-ultra volumio[963]: info: Loading plugin "spop"... May 02 04:46:24 hi-fi-ultra volumio[963]: info: Loading plugin "tidal"... May 02 04:46:27 hi-fi-ultra volumio[963]: info: Loading plugin "gpios"... May 02 04:46:27 hi-fi-ultra volumio[963]: error: ATTENTION!!!: Plugin gpios does not return adequate promise from onVolumioStart: please update! May 02 04:46:27 hi-fi-ultra volumio[963]: info: Loading plugin "updater_comm"... May 02 04:46:27 hi-fi-ultra volumio[963]: info: Plugin mpdemulation is not enabled May 02 04:46:27 hi-fi-ultra volumio[963]: info: Loading plugin "rest_api"... May 02 04:46:27 hi-fi-ultra volumio[963]: info: Loading plugin "websocket"... May 02 04:46:27 hi-fi-ultra volumio[963]: info: ___________ START PLUGINS ___________ May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 02 04:46:27 hi-fi-ultra volumio[963]: info: Adding METAVOLUMIO REST API Endpoints May 02 04:46:27 hi-fi-ultra volumio[963]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 02 04:46:27 hi-fi-ultra volumio[963]: info: [1714625187438] CoreMusicLibrary::Adding element Shairport-Sync May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 02 04:46:27 hi-fi-ultra sudo[1230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name hi-fi-ultra May 02 04:46:27 hi-fi-ultra volumio[963]: info: Preparing CD Folders May 02 04:46:27 hi-fi-ultra volumio[963]: info: Adding CD REST API Endpoints May 02 04:46:27 hi-fi-ultra volumio[963]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller May 02 04:46:27 hi-fi-ultra volumio[963]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller May 02 04:46:27 hi-fi-ultra volumio[963]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller May 02 04:46:27 hi-fi-ultra volumio[963]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller May 02 04:46:27 hi-fi-ultra volumio[963]: info: Detecting CD presence with Flag file May 02 04:46:27 hi-fi-ultra volumio[963]: info: Streaming services startup May 02 04:46:27 hi-fi-ultra sudo[1230]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:27 hi-fi-ultra volumio[963]: info: Starting Streaming Daemon May 02 04:46:27 hi-fi-ultra sudo[1230]: pam_unix(sudo:session): session closed for user root May 02 04:46:27 hi-fi-ultra sudo[1239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 02 04:46:27 hi-fi-ultra sudo[1239]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:27 hi-fi-ultra systemd[1]: Stopping Volumio Streaming Daemon... May 02 04:46:27 hi-fi-ultra systemd[1]: Starting Volumio Streaming Daemon... May 02 04:46:27 hi-fi-ultra systemd[1]: Started Volumio Streaming Daemon. May 02 04:46:27 hi-fi-ultra sudo[1239]: pam_unix(sudo:session): session closed for user root May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 02 04:46:27 hi-fi-ultra volumio[963]: info: [1714625187543] CoreMusicLibrary::Adding element Webradio May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 02 04:46:27 hi-fi-ultra volumio-streaming-daemon[1250]: ############################ May 02 04:46:27 hi-fi-ultra volumio-streaming-daemon[1250]: # Volumio Streaming Daemon # May 02 04:46:27 hi-fi-ultra volumio-streaming-daemon[1250]: # Running on port 7777 # May 02 04:46:27 hi-fi-ultra volumio-streaming-daemon[1250]: ############################ May 02 04:46:27 hi-fi-ultra volumio-streaming-daemon[1250]: Checking variant in static cache May 02 04:46:27 hi-fi-ultra volumio-streaming-daemon[1250]: Enabled services: May 02 04:46:27 hi-fi-ultra volumio-streaming-daemon[1250]: 1) tidal May 02 04:46:27 hi-fi-ultra volumio-streaming-daemon[1250]: 2) qobuz May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 02 04:46:27 hi-fi-ultra volumio[963]: error: Hi Res Audio Failed Login: Missing Login Data May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 02 04:46:27 hi-fi-ultra volumio[963]: [SpotifyConnect] Creating VLS config file May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: [SpotifyConnect] SpotifyConnect Daemon config issues! May 02 04:46:27 hi-fi-ultra volumio[963]: [SpotifyConnect] volspotify config error: [ '#initial-volume = undefined', [length]: 1 ] May 02 04:46:27 hi-fi-ultra volumio[963]: [SpotifyConnect] Starting metadata listener May 02 04:46:27 hi-fi-ultra volumio[963]: error: Plugin gpios does not return adequate promise from onStart: please update! May 02 04:46:27 hi-fi-ultra sudo[1260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service May 02 04:46:27 hi-fi-ultra sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:27 hi-fi-ultra volumio[963]: info: Loading i18n strings for locale en May 02 04:46:27 hi-fi-ultra volumio[963]: Updating browse sources language May 02 04:46:27 hi-fi-ultra volumio[963]: Cannot find translation for sourceBluetooth May 02 04:46:27 hi-fi-ultra volumio[963]: Cannot find translation for sourceUSB/PC May 02 04:46:27 hi-fi-ultra volumio[963]: Cannot find translation for sourceShairport-Sync May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 02 04:46:27 hi-fi-ultra systemd[1]: Starting Volspotconnect2 Daemon... May 02 04:46:27 hi-fi-ultra sudo[1260]: pam_unix(sudo:session): session closed for user root May 02 04:46:27 hi-fi-ultra systemd[1]: Started Volspotconnect2 Daemon. May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::initPlayerControls May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[963]: info: BOOT COMPLETED May 02 04:46:27 hi-fi-ultra volumio[963]: [Metrics] CommandRouter: 12s 664.54ms May 02 04:46:27 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 04:46:27 hi-fi-ultra volumio[1265]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 02 04:46:27 hi-fi-ultra volumio[1265]: Reading Config from "/tmp/volspotify.toml" May 02 04:46:27 hi-fi-ultra volumio[1265]: Malformed config key: missing field `Authentication` May 02 04:46:27 hi-fi-ultra systemd[1]: volspotconnect.service: main process exited, code=exited, status=1/FAILURE May 02 04:46:27 hi-fi-ultra systemd[1]: Unit volspotconnect.service entered failed state. May 02 04:46:30 hi-fi-ultra systemd[1]: volspotconnect.service holdoff time over, scheduling restart. May 02 04:46:30 hi-fi-ultra systemd[1]: Stopping Volspotconnect2 Daemon... May 02 04:46:30 hi-fi-ultra systemd[1]: Starting Volspotconnect2 Daemon... May 02 04:46:30 hi-fi-ultra systemd[1]: Started Volspotconnect2 Daemon. May 02 04:46:30 hi-fi-ultra volumio[1275]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 02 04:46:30 hi-fi-ultra volumio[1275]: Reading Config from "/tmp/volspotify.toml" May 02 04:46:30 hi-fi-ultra volumio[1275]: Malformed config key: missing field `Authentication` May 02 04:46:30 hi-fi-ultra systemd[1]: volspotconnect.service: main process exited, code=exited, status=1/FAILURE May 02 04:46:30 hi-fi-ultra systemd[1]: Unit volspotconnect.service entered failed state. May 02 04:46:32 hi-fi-ultra systemd[1]: volspotconnect.service holdoff time over, scheduling restart. May 02 04:46:32 hi-fi-ultra systemd[1]: Stopping Volspotconnect2 Daemon... May 02 04:46:32 hi-fi-ultra systemd[1]: Starting Volspotconnect2 Daemon... May 02 04:46:32 hi-fi-ultra systemd[1]: Started Volspotconnect2 Daemon. May 02 04:46:32 hi-fi-ultra volumio[1278]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 02 04:46:32 hi-fi-ultra volumio[1278]: Reading Config from "/tmp/volspotify.toml" May 02 04:46:32 hi-fi-ultra volumio[1278]: Malformed config key: missing field `Authentication` May 02 04:46:32 hi-fi-ultra systemd[1]: volspotconnect.service: main process exited, code=exited, status=1/FAILURE May 02 04:46:32 hi-fi-ultra systemd[1]: Unit volspotconnect.service entered failed state. May 02 04:46:33 hi-fi-ultra volumio[963]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo May 02 04:46:33 hi-fi-ultra volumio[963]: info: CoreCommandRouter::Close All Modals sent May 02 04:46:33 hi-fi-ultra volumio[963]: info: CoreCommandRouter::Close All Modals sent May 02 04:46:33 hi-fi-ultra volumio[963]: Express server listening on port 3000 May 02 04:46:33 hi-fi-ultra volumio[963]: [Metrics] WebUI: 19s 5.67ms May 02 04:46:33 hi-fi-ultra volumio[963]: Volumio Calling Home May 02 04:46:33 hi-fi-ultra volumio[963]: info: CoreStateMachine::resetVolumioState May 02 04:46:33 hi-fi-ultra volumio[963]: info: CoreStateMachine::getcurrentVolume May 02 04:46:33 hi-fi-ultra volumio[963]: info: CoreCommandRouter::volumioRetrievevolume May 02 04:46:33 hi-fi-ultra volumio[963]: info: Stopping AccessToken refresher cron for QOBUZ May 02 04:46:33 hi-fi-ultra volumio[963]: info: AccessToken refresher cron started for QOBUZ May 02 04:46:33 hi-fi-ultra volumio[963]: info: Stopping AccessToken refresher cron May 02 04:46:33 hi-fi-ultra volumio[963]: info: AccessToken refresher cron started May 02 04:46:33 hi-fi-ultra kernel: uart-pl011 3f201000.serial: no DMA platform data May 02 04:46:33 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 04:46:33 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 04:46:33 hi-fi-ultra sudo[1293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 02 04:46:33 hi-fi-ultra sudo[1293]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:33 hi-fi-ultra sudo[1296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 02 04:46:33 hi-fi-ultra sudo[1293]: pam_unix(sudo:session): session closed for user root May 02 04:46:33 hi-fi-ultra sudo[1296]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:33 hi-fi-ultra sudo[1296]: pam_unix(sudo:session): session closed for user root May 02 04:46:33 hi-fi-ultra sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* May 02 04:46:33 hi-fi-ultra sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:33 hi-fi-ultra sudo[1306]: pam_unix(sudo:session): session closed for user root May 02 04:46:33 hi-fi-ultra volumio[963]: info: Cannot read play queue from file May 02 04:46:33 hi-fi-ultra volumio[963]: info: Serial port opened successfully May 02 04:46:33 hi-fi-ultra sudo[1329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart leddaemon.service May 02 04:46:33 hi-fi-ultra sudo[1329]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:33 hi-fi-ultra systemd[1]: Starting LED Daemon Service... May 02 04:46:33 hi-fi-ultra systemd[1]: Started LED Daemon Service. May 02 04:46:33 hi-fi-ultra sudo[1329]: pam_unix(sudo:session): session closed for user root May 02 04:46:33 hi-fi-ultra led-daemon[1334]: Starting Network LED Daemon May 02 04:46:33 hi-fi-ultra volumio[963]: Unable to parse: May 02 04:46:33 hi-fi-ultra volumio[963]: Simple mixer control 'PCM',0 May 02 04:46:33 hi-fi-ultra volumio[963]: Capabilities: pswitch pswitch-joined May 02 04:46:33 hi-fi-ultra volumio[963]: Playback channels: Mono May 02 04:46:33 hi-fi-ultra volumio[963]: Mono: Playback [on] May 02 04:46:33 hi-fi-ultra volumio[963]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output May 02 04:46:33 hi-fi-ultra volumio[963]: info: Volumio called home May 02 04:46:33 hi-fi-ultra volumio[963]: info: Setting Device type: Raspberry PI May 02 04:46:33 hi-fi-ultra volumio[963]: [SpotifyConnect] Vollibrespot Daemon service started! May 02 04:46:33 hi-fi-ultra volumio[963]: [Metrics] SpotifyConnect: 6s 259.54ms May 02 04:46:33 hi-fi-ultra volumio[963]: info: Bluetooth name changed to hi-fi-ultra May 02 04:46:33 hi-fi-ultra volumio[963]: info: Shairport-Sync Stopped May 02 04:46:33 hi-fi-ultra volumio[963]: info: MPD running with PID737 May 02 04:46:33 hi-fi-ultra volumio[963]: ,establishing connection May 02 04:46:33 hi-fi-ultra sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 May 02 04:46:33 hi-fi-ultra sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:33 hi-fi-ultra sudo[1344]: pam_unix(sudo:session): session closed for user root May 02 04:46:34 hi-fi-ultra volumio[963]: info: VolumeController:: Volume=undefined Mute =false May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreStateMachine::pushState May 02 04:46:34 hi-fi-ultra volumio[963]: info: CorePlayQueue::getTrack 0 May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::volumioPushState May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreStateMachine::updateTrackBlock May 02 04:46:34 hi-fi-ultra volumio[963]: info: CorePlayQueue::getTrackBlock May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::volumioRetrievevolume May 02 04:46:34 hi-fi-ultra volumio[963]: info: May 02 04:46:34 hi-fi-ultra volumio[963]: ---------------------------- Client requests Volume NaN May 02 04:46:34 hi-fi-ultra volumio[963]: info: VolumeController::SetAlsaVolumeNaN May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreStateMachine::pushState May 02 04:46:34 hi-fi-ultra volumio[963]: info: CorePlayQueue::getTrack 0 May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::volumioPushState May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 04:46:34 hi-fi-ultra volumio[963]: Error in parsing play status: TypeError: Cannot read property '0' of undefined May 02 04:46:34 hi-fi-ultra volumio[963]: Error in parsing play status: TypeError: Cannot read property '0' of undefined May 02 04:46:34 hi-fi-ultra volumio[963]: Error in parsing play status: TypeError: Cannot read property '0' of undefined May 02 04:46:34 hi-fi-ultra volumio[963]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 May 02 04:46:34 hi-fi-ultra volumio[963]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 02 04:46:34 hi-fi-ultra volumio[963]: info: Version has changed, forcing UI Reload May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::Reload Ui May 02 04:46:34 hi-fi-ultra volumio[963]: info: Received Push USB{"activeRoute":"0","powerShutdown":"0"} May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , setPCInputReturn May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , registerLastUsbStatus May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: inputs , disablePCInput May 02 04:46:34 hi-fi-ultra systemd[1]: volspotconnect.service holdoff time over, scheduling restart. May 02 04:46:34 hi-fi-ultra systemd[1]: Stopping Volspotconnect2 Daemon... May 02 04:46:34 hi-fi-ultra systemd[1]: Starting Volspotconnect2 Daemon... May 02 04:46:34 hi-fi-ultra systemd[1]: Started Volspotconnect2 Daemon. May 02 04:46:34 hi-fi-ultra volumio[1355]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 02 04:46:34 hi-fi-ultra volumio[1355]: Reading Config from "/tmp/volspotify.toml" May 02 04:46:34 hi-fi-ultra volumio[963]: error: updateQueue error: null May 02 04:46:34 hi-fi-ultra volumio[963]: error: Failed LSINFO: Error: [50@0] {} No such directory May 02 04:46:34 hi-fi-ultra volumio[1355]: [Vollibrespot] : Using Alsa backend with device: plughw:5 May 02 04:46:34 hi-fi-ultra volumio[963]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified May 02 04:46:34 hi-fi-ultra volumio[963]: xcb_connection_has_error() returned true May 02 04:46:34 hi-fi-ultra volumio[963]: info: Setting volume on startup at undefined May 02 04:46:34 hi-fi-ultra volumio[963]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified May 02 04:46:34 hi-fi-ultra volumio[963]: xcb_connection_has_error() returned true May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreStateMachine::setRepeat true single undefined May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreStateMachine::pushState May 02 04:46:34 hi-fi-ultra volumio[963]: info: CorePlayQueue::getTrack 0 May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::volumioPushState May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 04:46:34 hi-fi-ultra volumio[1355]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreStateMachine::setRandom null May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreStateMachine::pushState May 02 04:46:34 hi-fi-ultra volumio[963]: info: CorePlayQueue::getTrack 0 May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::volumioPushState May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 04:46:34 hi-fi-ultra volumio[963]: Error in parsing play status: TypeError: Cannot read property '0' of undefined May 02 04:46:34 hi-fi-ultra volumio[963]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function May 02 04:46:34 hi-fi-ultra volumio[963]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function May 02 04:46:34 hi-fi-ultra volumio[963]: info: VolumeController:: Volume=undefined Mute =false May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreStateMachine::pushState May 02 04:46:34 hi-fi-ultra volumio[963]: info: CorePlayQueue::getTrack 0 May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::volumioPushState May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 02 04:46:34 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 02 04:46:34 hi-fi-ultra sudo[1359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio May 02 04:46:34 hi-fi-ultra sudo[1359]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 04:46:34 hi-fi-ultra sudo[1359]: pam_unix(sudo:session): session closed for user root May 02 04:46:34 hi-fi-ultra volumio[963]: No protocol specified May 02 04:46:34 hi-fi-ultra volumio[963]: xcb_connection_has_error() returned true May 02 04:46:34 hi-fi-ultra volumio[963]: Error in parsing play status: TypeError: Cannot read property '0' of undefined May 02 04:46:34 hi-fi-ultra volumio[963]: Error in parsing play status: TypeError: Cannot read property '0' of undefined May 02 04:46:35 hi-fi-ultra pulseaudio[1374]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 May 02 04:46:35 hi-fi-ultra pulseaudio[1374]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 May 02 04:46:35 hi-fi-ultra pulseaudio[1374]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist May 02 04:46:35 hi-fi-ultra bluetoothd[695]: Endpoint registered: sender=:1.17 path=/MediaEndpoint/A2DPSource May 02 04:46:35 hi-fi-ultra bluetoothd[695]: Endpoint registered: sender=:1.17 path=/MediaEndpoint/A2DPSink May 02 04:46:35 hi-fi-ultra volumio[963]: Error in parsing play status: TypeError: Cannot read property '0' of undefined May 02 04:46:35 hi-fi-ultra volumio-remote-updater[704]: [2024-05-02 04:46:35] [connect] Successful connection May 02 04:46:35 hi-fi-ultra volumio-remote-updater[704]: [2024-05-02 04:46:35] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1714625195 101 May 02 04:46:35 hi-fi-ultra volumio[963]: Error in parsing play status: TypeError: Cannot read property '0' of undefined May 02 04:46:35 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 02 04:46:36 hi-fi-ultra volumio-streaming-daemon[1250]: Checking variant in static cache May 02 04:46:36 hi-fi-ultra volumio[963]: info: Fetching Streaming Services browse cache May 02 04:46:37 hi-fi-ultra volumio[963]: info: Checking Spotify Web API May 02 04:46:38 hi-fi-ultra volumio[963]: Error in parsing play status: TypeError: Cannot read property '0' of undefined May 02 04:46:57 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 02 04:46:57 hi-fi-ultra volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 04:47:02 hi-fi-ultra volumio[963]: Discovery: adding 974a412f-13d8-4008-94fb-21cf73f5c296 May 02 04:47:02 hi-fi-ultra volumio[963]: info: mDNS: Found device hi-fi-ultra May 02 04:47:02 hi-fi-ultra volumio[963]: info: CoreCommandRouter::volumioGetState May 02 04:47:02 hi-fi-ultra volumio[963]: info: CorePlayQueue::getTrack 0 May 02 04:47:02 hi-fi-ultra volumio[963]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 02 04:47:02 hi-fi-ultra volumio[963]: Error: The value NaN is not a number May 02 04:47:02 hi-fi-ultra volumio[963]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) May 02 04:47:02 hi-fi-ultra volumio[963]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) May 02 04:47:02 hi-fi-ultra volumio[963]: at ControllerVolumioDiscovery.pushMultiRoomStatusUpdate (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:287:25) May 02 04:47:02 hi-fi-ultra volumio[963]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:10) May 02 04:47:02 hi-fi-ultra volumio[963]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:202:12) May 02 04:47:02 hi-fi-ultra volumio[963]: at emitTwo (events.js:126:13) May 02 04:47:02 hi-fi-ultra volumio[963]: at Browser.emit (events.js:214:7) May 02 04:47:02 hi-fi-ultra volumio[963]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) May 02 04:47:02 hi-fi-ultra volumio[963]: at next (/volumio/node_modules/mdns/lib/browser.js:104:7) May 02 04:47:02 hi-fi-ultra volumio[963]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 May 02 04:47:02 hi-fi-ultra volumio[963]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) May 02 04:47:02 hi-fi-ultra volumio[963]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) May 02 04:47:02 hi-fi-ultra volumio[963]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 02 04:47:03 hi-fi-ultra sudo[1507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-02 04:46 May 02 04:47:03 hi-fi-ultra sudo[1507]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="projectsbus2" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 13 17:22:02 CEST 2022" VOLUMIO_VERSION="1.079" VOLUMIO_HARDWARE="pi" VOLUMIO_VENDOR="Pro-Ject Audio Systems" VOLUMIO_MODEL="Stream Box S2 ultra" VOLUMIO_VENDOR_MODEL="Pro-Ject Stream Box S2 ultra" VOLUMIO_HASH="a5127ace113e6b9fcf2a1eaed5431093"