-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Wed 2024-02-28 14:17:41 UTC. -- Feb 28 14:17:26 volumio systemd[1]: Started Journal Service. Feb 28 14:17:26 volumio fake-hwclock[251]: Wed Feb 28 14:17:26 UTC 2024 Feb 28 14:17:26 volumio systemd[1]: Mounted POSIX Message Queue File System. Feb 28 14:17:26 volumio systemd[1]: Started Load Kernel Modules. Feb 28 14:17:26 volumio systemd[1]: Mounted Kernel Debug File System. Feb 28 14:17:26 volumio systemd[1]: Started Create list of required static device nodes for the current kernel. Feb 28 14:17:26 volumio systemd[1]: Started Restore / save the current clock. Feb 28 14:17:26 volumio systemd[1]: Started Remount Root and Kernel File Systems. Feb 28 14:17:26 volumio systemd[1]: Mounted RPC Pipe File System. Feb 28 14:17:26 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Feb 28 14:17:26 volumio systemd[1]: Starting Create System Users... Feb 28 14:17:26 volumio systemd[1]: Starting Load/Save Random Seed... Feb 28 14:17:26 volumio systemd[1]: Mounting FUSE Control File System... Feb 28 14:17:26 volumio systemd[1]: Starting Apply Kernel Variables... Feb 28 14:17:26 volumio systemd[1]: Mounting Kernel Configuration File System... Feb 28 14:17:26 volumio systemd[1]: Started Load/Save Random Seed. Feb 28 14:17:26 volumio systemd[1]: Mounted FUSE Control File System. Feb 28 14:17:26 volumio systemd[1]: Mounted Kernel Configuration File System. Feb 28 14:17:26 volumio systemd[1]: Started Apply Kernel Variables. Feb 28 14:17:26 volumio systemd[1]: Started Create System Users. Feb 28 14:17:26 volumio systemd[1]: Starting Create Static Device Nodes in /dev... Feb 28 14:17:26 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 28 14:17:26 volumio systemd[1]: Started Create Static Device Nodes in /dev. Feb 28 14:17:26 volumio systemd[1]: Starting udev Kernel Device Manager... Feb 28 14:17:26 volumio systemd[1]: Reached target Local File Systems (Pre). Feb 28 14:17:26 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Feb 28 14:17:26 volumio systemd[1]: Mounting /tmp... Feb 28 14:17:26 volumio systemd[1]: Mounting /var/spool/cups... Feb 28 14:17:26 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Feb 28 14:17:26 volumio systemd[1]: Mounting /var/log... Feb 28 14:17:26 volumio systemd[1]: Mounted /var/spool/cups. Feb 28 14:17:26 volumio systemd[1]: Mounted /tmp. Feb 28 14:17:26 volumio systemd[1]: Mounting /var/spool/cups/tmp... Feb 28 14:17:26 volumio systemd[1]: Mounted /var/log. Feb 28 14:17:26 volumio systemd-udevd[276]: libkmod: ERROR ../libkmod/libkmod-config.c:656 kmod_config_parse: /etc/modprobe.d/alsa-base.conf line 1: ignoring bad line starting with '#' Feb 28 14:17:26 volumio systemd-udevd[276]: libkmod: ERROR ../libkmod/libkmod-config.c:656 kmod_config_parse: /etc/modprobe.d/alsa-base.conf line 2: ignoring bad line starting with '#' Feb 28 14:17:26 volumio systemd[1]: Starting Flush Journal to Persistent Storage... Feb 28 14:17:26 volumio systemd[1]: Mounted /var/spool/cups/tmp. Feb 28 14:17:26 volumio systemd[1]: Started udev Kernel Device Manager. Feb 28 14:17:26 volumio systemd-journald[246]: Runtime journal (/run/log/journal/cf6bfbb6a9d5e0f5aa52349362a21b6f) is 7.5M, max 30.0M, 22.5M free. Feb 28 14:17:26 volumio systemd[1]: Started Flush Journal to Persistent Storage. Feb 28 14:17:26 volumio kernel: cfg80211: World regulatory domain updated: Feb 28 14:17:26 volumio kernel: cfg80211: DFS Master region: unset Feb 28 14:17:26 volumio kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Feb 28 14:17:26 volumio systemd[1]: Started udev Coldplug all Devices. Feb 28 14:17:26 volumio kernel: cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Feb 28 14:17:26 volumio kernel: cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz, 92000 KHz AUTO), (N/A, 2000 mBm), (N/A) Feb 28 14:17:26 volumio systemd[1]: Starting Helper to synchronize boot up for ifupdown... Feb 28 14:17:26 volumio systemd[1]: Starting Show Plymouth Boot Screen... Feb 28 14:17:26 volumio kernel: cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Feb 28 14:17:26 volumio kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Feb 28 14:17:26 volumio kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Feb 28 14:17:26 volumio kernel: cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Feb 28 14:17:26 volumio systemd-udevd[292]: Using default interface naming scheme 'v240'. Feb 28 14:17:26 volumio kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Feb 28 14:17:26 volumio kernel: cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Feb 28 14:17:26 volumio systemd-udevd[292]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 28 14:17:26 volumio systemd-udevd[292]: link_config: could not get ethtool features for eth0 Feb 28 14:17:26 volumio systemd-udevd[292]: Could not set offload features of eth0: Device or resource busy Feb 28 14:17:26 volumio systemd[1]: Received SIGRTMIN+20 from PID 302 (plymouthd). Feb 28 14:17:26 volumio systemd[1]: Started Show Plymouth Boot Screen. Feb 28 14:17:26 volumio systemd[1]: Found device /dev/ttyS3. Feb 28 14:17:26 volumio systemd-udevd[290]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 28 14:17:26 volumio systemd-udevd[288]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 28 14:17:26 volumio kernel: random: nonblocking pool is initialized Feb 28 14:17:26 volumio systemd-udevd[287]: Using default interface naming scheme 'v240'. Feb 28 14:17:26 volumio systemd-udevd[287]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 28 14:17:26 volumio systemd-udevd[283]: Process '/sbin/crda' failed with exit code 255. Feb 28 14:17:26 volumio systemd-udevd[285]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 28 14:17:26 volumio systemd-udevd[296]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 28 14:17:26 volumio systemd[1]: Found device /dev/disk/by-uuid/0A1E-49F8. Feb 28 14:17:26 volumio systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Feb 28 14:17:26 volumio systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped. Feb 28 14:17:26 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Feb 28 14:17:26 volumio systemd[1]: Condition check resulted in Arbitrary Executable File Formats File System Automount Point being skipped. Feb 28 14:17:26 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Feb 28 14:17:26 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Feb 28 14:17:26 volumio systemd[1]: Condition check resulted in Huge Pages File System being skipped. Feb 28 14:17:26 volumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/0A1E-49F8... Feb 28 14:17:26 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Feb 28 14:17:26 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Feb 28 14:17:26 volumio systemd[1]: Reached target Paths. Feb 28 14:17:26 volumio systemd[1]: Reached target Local Encrypted Volumes. Feb 28 14:17:26 volumio systemd[1]: Starting Load/Save RF Kill Switch Status... Feb 28 14:17:26 volumio systemd[1]: Started File System Check Daemon to report status. Feb 28 14:17:27 volumio systemd[1]: Started Load/Save RF Kill Switch Status. Feb 28 14:17:27 volumio systemd-fsck[397]: fsck.fat 4.1 (2017-01-24) Feb 28 14:17:27 volumio systemd-fsck[397]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Feb 28 14:17:27 volumio systemd-fsck[397]: Automatically removing dirty bit. Feb 28 14:17:27 volumio systemd-fsck[397]: Performing changes. Feb 28 14:17:27 volumio systemd-fsck[397]: /dev/mmcblk1p1: 88 files, 10098/30651 clusters Feb 28 14:17:27 volumio systemd[1]: Started File System Check on /dev/disk/by-uuid/0A1E-49F8. Feb 28 14:17:27 volumio systemd[1]: Mounting /boot... Feb 28 14:17:27 volumio systemd[1]: Mounted /boot. Feb 28 14:17:27 volumio systemd[1]: Reached target Local File Systems. Feb 28 14:17:27 volumio systemd[1]: Starting Create Volatile Files and Directories... Feb 28 14:17:27 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Feb 28 14:17:27 volumio systemd[1]: Started ifup for eth0. Feb 28 14:17:27 volumio systemd[1]: Started ifup for wlan0. Feb 28 14:17:27 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Feb 28 14:17:27 volumio systemd[1]: Starting Preprocess NFS configuration... Feb 28 14:17:27 volumio systemd[1]: Received SIGRTMIN+20 from PID 302 (plymouthd). Feb 28 14:17:27 volumio systemd[1]: plymouth-read-write.service: Succeeded. Feb 28 14:17:27 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Feb 28 14:17:27 volumio systemd[1]: nfs-config.service: Succeeded. Feb 28 14:17:27 volumio systemd[1]: Started Preprocess NFS configuration. Feb 28 14:17:27 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Feb 28 14:17:27 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Feb 28 14:17:27 volumio systemd[1]: Reached target NFS client services. Feb 28 14:17:27 volumio systemd[1]: Started Create Volatile Files and Directories. Feb 28 14:17:27 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Feb 28 14:17:27 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Feb 28 14:17:27 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Feb 28 14:17:27 volumio systemd[1]: Starting RPC bind portmap service... Feb 28 14:17:27 volumio kernel: IPVS: Creating netns size=1496 id=1 Feb 28 14:17:27 volumio kernel: IPVS: ftp: loaded support on port[0] = 21 Feb 28 14:17:27 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Feb 28 14:17:27 volumio systemd[1]: Reached target System Initialization. Feb 28 14:17:27 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Feb 28 14:17:27 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Feb 28 14:17:27 volumio systemd[1]: Listening on triggerhappy.socket. Feb 28 14:17:27 volumio systemd[1]: Reached target Sockets. Feb 28 14:17:27 volumio systemd[1]: man-db.timer: Not using persistent file timestamp Sun 2024-03-31 00:00:25 UTC as it is in the future. Feb 28 14:17:27 volumio systemd[1]: Started Daily man-db regeneration. Feb 28 14:17:27 volumio systemd[1]: apt-daily.timer: Not using persistent file timestamp Sun 2024-03-31 05:12:29 UTC as it is in the future. Feb 28 14:17:27 volumio systemd[1]: Started Daily apt download activities. Feb 28 14:17:27 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Feb 28 14:17:27 volumio systemd[1]: Started Volumio Splash. Feb 28 14:17:27 volumio systemd[1]: Reached target Basic System. Feb 28 14:17:27 volumio systemd[1]: Started Volumio Log Rotation Service. Feb 28 14:17:27 volumio systemd[449]: volumiosplash.service: Failed to execute command: No such file or directory Feb 28 14:17:27 volumio systemd[449]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory Feb 28 14:17:27 volumio systemd[1]: Started D-Bus System Message Bus. Feb 28 14:17:27 volumio systemd[1]: Starting triggerhappy global hotkey daemon... Feb 28 14:17:27 volumio systemd[1]: Starting WPA supplicant... Feb 28 14:17:27 volumio systemd[1]: Starting Wireless Services... Feb 28 14:17:27 volumio systemd[1]: Started Manage Sound Card State (restore and store). Feb 28 14:17:27 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Feb 28 14:17:27 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Feb 28 14:17:27 volumio thd[453]: Unable to parse trigger line: Feb 28 14:17:27 volumio thd[453]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Feb 28 14:17:27 volumio thd[453]: Unable to parse trigger line: Feb 28 14:17:27 volumio thd[453]: Found socket passed from systemd Feb 28 14:17:27 volumio systemd[1]: Started Tinkerboard BT INIT. Feb 28 14:17:27 volumio alsactl[456]: alsactl 1.1.8 daemon started Feb 28 14:17:27 volumio systemd[1]: Starting Login Service... Feb 28 14:17:27 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Feb 28 14:17:27 volumio systemd[1]: Starting DHCP Client Daemon... Feb 28 14:17:27 volumio systemd[1]: Started Volumio Iptables Module. Feb 28 14:17:27 volumio systemd[1]: Starting Save/Restore Sound Card State... Feb 28 14:17:27 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Feb 28 14:17:27 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Feb 28 14:17:27 volumio systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Sun 2024-03-31 06:50:29 UTC as it is in the future. Feb 28 14:17:27 volumio systemd[1]: Started Daily apt upgrade and clean activities. Feb 28 14:17:27 volumio systemd[1]: Reached target Timers. Feb 28 14:17:27 volumio systemd[1]: Started volumio-remote-updater.service. Feb 28 14:17:27 volumio systemd[1]: Started triggerhappy global hotkey daemon. Feb 28 14:17:27 volumio systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC Feb 28 14:17:27 volumio systemd[1]: volumiosplash.service: Failed with result 'exit-code'. Feb 28 14:17:27 volumio systemd-logind[461]: New seat seat0. Feb 28 14:17:27 volumio avahi-daemon[462]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Feb 28 14:17:27 volumio avahi-daemon[462]: Successfully dropped root privileges. Feb 28 14:17:27 volumio avahi-daemon[462]: avahi-daemon 0.7 starting up. Feb 28 14:17:27 volumio systemd-logind[461]: Watching system buttons on /dev/input/event1 (RC for dw_hdmi) Feb 28 14:17:27 volumio systemd-logind[461]: Watching system buttons on /dev/input/event2 (gpio-keys) Feb 28 14:17:27 volumio kernel: ttyS0 - failed to request DMA Feb 28 14:17:27 volumio systemd[1]: Started Login Service. Feb 28 14:17:27 volumio wpa_supplicant[454]: Successfully initialized wpa_supplicant Feb 28 14:17:27 volumio systemd[1]: Started Save/Restore Sound Card State. Feb 28 14:17:27 volumio avahi-daemon[462]: Successfully called chroot(). Feb 28 14:17:27 volumio avahi-daemon[462]: Successfully dropped remaining capabilities. Feb 28 14:17:27 volumio systemd[1]: Started WPA supplicant. Feb 28 14:17:27 volumio avahi-daemon[462]: No service file found in /etc/avahi/services. Feb 28 14:17:27 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Feb 28 14:17:27 volumio systemd[1]: Reached target Sound Card. Feb 28 14:17:27 volumio systemd[1]: iptables.service: Succeeded. Feb 28 14:17:27 volumio sh[404]: eth0=eth0 Feb 28 14:17:27 volumio volumio-remote-updater[468]: Error: No active session Feb 28 14:17:27 volumio volumio[467]: Could not open config: /tmp/upmpdcli.conf Feb 28 14:17:27 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 28 14:17:27 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 28 14:17:28 volumio kernel: rtk_btcoex: Open BTCOEX Feb 28 14:17:28 volumio kernel: rtk_btcoex: create_udpsocket: connect_port: 30001 Feb 28 14:17:28 volumio kernel: rtk_btcoex: send msg INVITE_REQ with len:11 Feb 28 14:17:28 volumio systemd[1]: Starting Bluetooth service... Feb 28 14:17:28 volumio kernel: rtk_btcoex: BTCOEX hci_rev 0x1e3e Feb 28 14:17:28 volumio kernel: rtk_btcoex: BTCOEX lmp_subver 0xe40e Feb 28 14:17:28 volumio bluetoothd[517]: Bluetooth daemon 5.50 Feb 28 14:17:28 volumio bluetoothd[517]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Feb 28 14:17:28 volumio systemd[1]: Started Bluetooth service. Feb 28 14:17:28 volumio systemd[1]: Reached target Bluetooth. Feb 28 14:17:28 volumio bluetoothd[517]: Starting SDP server Feb 28 14:17:28 volumio bluetoothd[517]: Excluding (cli) sap Feb 28 14:17:28 volumio bluetoothd[517]: kernel lacks bnep-protocol support Feb 28 14:17:28 volumio bluetoothd[517]: System does not support network plugin Feb 28 14:17:28 volumio bluetoothd[517]: Bluetooth management interface 1.10 initialized Feb 28 14:17:28 volumio dbus-daemon[451]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=517 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Feb 28 14:17:28 volumio systemd[1]: Starting Hostname Service... Feb 28 14:17:28 volumio wireless.js[455]: Cleaning previous... Feb 28 14:17:28 volumio avahi-daemon[462]: Network interface enumeration completed. Feb 28 14:17:28 volumio systemd[1]: Started RPC bind portmap service. Feb 28 14:17:28 volumio volumio-remote-updater[468]: [2024-02-28 14:17:28] [info] asio async_connect error: system:111 (Connection refused) Feb 28 14:17:28 volumio volumio-remote-updater[468]: [2024-02-28 14:17:28] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 28 14:17:28 volumio volumio-remote-updater[468]: [2024-02-28 14:17:28] [error] handle_connect error: Underlying Transport Error Feb 28 14:17:28 volumio avahi-daemon[462]: Server startup complete. Host name is volumio.local. Local service cookie is 2639417432. Feb 28 14:17:28 volumio systemd[1]: Reached target Remote File Systems (Pre). Feb 28 14:17:28 volumio systemd[1]: Reached target Remote File Systems. Feb 28 14:17:28 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Feb 28 14:17:28 volumio kernel: IPVS: Creating netns size=1496 id=2 Feb 28 14:17:28 volumio systemd[1]: Reached target RPC Port Mapper. Feb 28 14:17:28 volumio kernel: IPVS: ftp: loaded support on port[0] = 21 Feb 28 14:17:28 volumio haveged[431]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.3.0 CTV); collect: 128K Feb 28 14:17:28 volumio haveged[431]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 12/40; sz: 15012/57848 Feb 28 14:17:28 volumio haveged[431]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00098 Feb 28 14:17:28 volumio haveged[431]: haveged: fills: 0, generated: 0 Feb 28 14:17:28 volumio kernel: usbcore: registered new interface driver snd-usb-audio Feb 28 14:17:28 volumio sudo[535]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 28 14:17:28 volumio dhcpcd[463]: DUID 00:01:00:01:2a:65:9b:60:d4:5d:64:d8:1c:f9 Feb 28 14:17:28 volumio dhcpcd[463]: eth0: IAID 64:d8:1c:f9 Feb 28 14:17:28 volumio dhcpcd[463]: eth0: adding address fe80::d65d:64ff:fed8:1cf9 Feb 28 14:17:28 volumio dhcpcd[463]: ipv6_addaddr1: Permission denied Feb 28 14:17:28 volumio dhcpcd[463]: eth0: probing address 192.168.1.123/24 Feb 28 14:17:28 volumio dhcpcd[463]: DUID 00:01:00:01:2a:65:9b:60:d4:5d:64:d8:1c:f9 Feb 28 14:17:28 volumio dhcpcd[463]: eth0: IAID 64:d8:1c:f9 Feb 28 14:17:28 volumio dhcpcd[463]: eth0: adding address fe80::d65d:64ff:fed8:1cf9 Feb 28 14:17:28 volumio dhcpcd[463]: ipv6_addaddr1: Permission denied Feb 28 14:17:28 volumio dhcpcd[463]: eth0: probing address 192.168.1.123/24 Feb 28 14:17:28 volumio sudo[535]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:28 volumio sh[405]: wlan0=wlan0 Feb 28 14:17:28 volumio sudo[535]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:28 volumio systemd-udevd[292]: Process '/bin/bash -c '/usr/local/bin/volumio scanaudioinputs'' failed with exit code 7. Feb 28 14:17:28 volumio loadcpufreq[541]: Loading cpufreq kernel modules...done (none). Feb 28 14:17:28 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Feb 28 14:17:28 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Feb 28 14:17:28 volumio sudo[616]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Feb 28 14:17:28 volumio dhcpcd[463]: wlan0: waiting for carrier Feb 28 14:17:28 volumio dhcpcd[463]: wlan0: waiting for carrier Feb 28 14:17:28 volumio sudo[616]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:28 volumio systemd-udevd[295]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 28 14:17:28 volumio systemd-logind[461]: Watching system buttons on /dev/input/event0 (Generic USB Audio) Feb 28 14:17:28 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown. Feb 28 14:17:28 volumio systemd[1]: Starting Raise network interfaces... Feb 28 14:17:28 volumio sudo[616]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:28 volumio cpufrequtils[617]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Feb 28 14:17:28 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Feb 28 14:17:28 volumio dhcpcd[463]: eth0: soliciting an IPv6 router Feb 28 14:17:28 volumio dhcpcd[463]: eth0: soliciting an IPv6 router Feb 28 14:17:28 volumio wireless.js[455]: Stopped aP Feb 28 14:17:28 volumio wireless.js[455]: Wireless Networking DISABLED, not starting wireless flow Feb 28 14:17:28 volumio dbus-daemon[451]: [system] Successfully activated service 'org.freedesktop.hostname1' Feb 28 14:17:28 volumio iwconfig[690]: Error for wireless request "Set Power Management" (8B2C) : Feb 28 14:17:28 volumio iwconfig[690]: SET failed on device wlan0 ; Operation not permitted. Feb 28 14:17:28 volumio systemd[1]: Started Hostname Service. Feb 28 14:17:28 volumio systemd[1]: wireless.service: Succeeded. Feb 28 14:17:28 volumio systemd[1]: Started Wireless Services. Feb 28 14:17:28 volumio systemd[1]: Started Volumio Backend Module. Feb 28 14:17:28 volumio systemd[1]: Started Volumio Cpu Tweaker. Feb 28 14:17:28 volumio systemd[1]: Started Start Volumio Kiosk. Feb 28 14:17:28 volumio startkiosk.sh[696]: Starting Volumio Kiosk with arguments for cursor display Feb 28 14:17:28 volumio systemd[1]: Started Raise network interfaces. Feb 28 14:17:28 volumio volumio-cpu-tweak[694]: Setting RT Priority for mpd Feb 28 14:17:28 volumio systemd[1]: Reached target Network. Feb 28 14:17:28 volumio systemd[1]: Starting Permit User Sessions... Feb 28 14:17:28 volumio systemd[1]: Starting Network Time Service... Feb 28 14:17:28 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Feb 28 14:17:28 volumio systemd[1]: Reached target Network is Online. Feb 28 14:17:28 volumio volumio-cpu-tweak[694]: pid 35's current scheduling policy: SCHED_OTHER Feb 28 14:17:28 volumio volumio-cpu-tweak[694]: pid 35's current scheduling priority: 0 Feb 28 14:17:28 volumio volumio-cpu-tweak[694]: Setting MPD Affinity Feb 28 14:17:28 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Feb 28 14:17:28 volumio systemd[1]: Starting Samba NMB Daemon... Feb 28 14:17:28 volumio volumio-cpu-tweak[694]: pid 3's current affinity mask: 1 Feb 28 14:17:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 28 14:17:28 volumio systemd[1]: Starting /etc/rc.local Compatibility... Feb 28 14:17:28 volumio volumio-cpu-tweak[694]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Feb 28 14:17:28 volumio volumio-cpu-tweak[694]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Feb 28 14:17:28 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Feb 28 14:17:28 volumio systemd[1]: Started Permit User Sessions. Feb 28 14:17:29 volumio sudo[744]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 0x48 0x48 Feb 28 14:17:29 volumio sudo[744]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:29 volumio ntpd[717]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 28 14:17:29 volumio ntpd[717]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Feb 28 14:17:29 volumio systemd[1]: Started Network Time Service. Feb 28 14:17:29 volumio sudo[744]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:29 volumio ntpd[764]: proto: precision = 0.583 usec (-21) Feb 28 14:17:29 volumio ntpd[764]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 28 14:17:29 volumio ifplugd(eth0)[772]: ifplugd 0.28 initializing. Feb 28 14:17:29 volumio ifplugd(eth0)[772]: Using interface eth0/D4:5D:64:D8:1C:F9 with driver (version: March_2013) Feb 28 14:17:29 volumio ifplugd(eth0)[772]: Using detection mode: SIOCETHTOOL Feb 28 14:17:29 volumio ifplugd(eth0)[772]: Initialization complete, link beat detected. Feb 28 14:17:29 volumio ntpd[764]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 28 14:17:29 volumio ntpd[764]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 428 days ago Feb 28 14:17:29 volumio ntpd[764]: Listen and drop on 0 v6wildcard [::]:123 Feb 28 14:17:29 volumio ntpd[764]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 28 14:17:29 volumio ntpd[764]: Listen normally on 2 lo 127.0.0.1:123 Feb 28 14:17:29 volumio ntpd[764]: Listening on routing socket on fd #19 for interface updates Feb 28 14:17:29 volumio ntpd[764]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 28 14:17:29 volumio ntpd[764]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 28 14:17:29 volumio systemd[1]: Started /etc/rc.local Compatibility. Feb 28 14:17:29 volumio systemd[1]: Starting Hold until boot process finishes up... Feb 28 14:17:29 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Feb 28 14:17:29 volumio systemd[1]: Received SIGRTMIN+21 from PID 302 (plymouthd). Feb 28 14:17:29 volumio systemd[1]: plymouth-start.service: Succeeded. Feb 28 14:17:29 volumio systemd[1]: plymouth-quit.service: Succeeded. Feb 28 14:17:29 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Feb 28 14:17:29 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Feb 28 14:17:29 volumio systemd[1]: Started Hold until boot process finishes up. Feb 28 14:17:29 volumio systemd[1]: Started Serial Getty on ttyS3. Feb 28 14:17:29 volumio systemd[1]: Reached target Login Prompts. Feb 28 14:17:29 volumio ifplugd(eth0)[772]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Feb 28 14:17:29 volumio ifplugd(eth0)[772]: client: ifup: interface eth0 already configured Feb 28 14:17:29 volumio startkiosk.sh[696]: X.Org X Server 1.20.4 Feb 28 14:17:29 volumio startkiosk.sh[696]: X Protocol Version 11, Revision 0 Feb 28 14:17:29 volumio startkiosk.sh[696]: Build Operating System: Linux 4.19.0-18-armmp-lpae armv7l Debian Feb 28 14:17:29 volumio startkiosk.sh[696]: Current Operating System: Linux volumio 4.4.71+ #23 SMP Sun Sep 20 12:23:26 CEST 2020 armv7l Feb 28 14:17:29 volumio startkiosk.sh[696]: Kernel command line: earlyprintk splash quiet plymouth.ignore-serial-consoles console=tty1 console=ttyS3,115200n8 rw init=/sbin/init imgpart=UUID=a32bdd9f-4394-4094-acb5-0caaf5cc0c55 imgfile=/volumio_current.sqsh bootpart=UUID=0A1E-49F8 datapart=UUID=b99674c9-d664-4bed-bdc2-2022b7526e29 bootconfig=/extlinux/extlinux.conf logo.nologo vt.global_cursor_default=0 loglevel=8 uboot_version=2017.07-g879646d1d6 root=/dev/mmcblk1p2 Feb 28 14:17:29 volumio startkiosk.sh[696]: Build Date: 18 December 2021 09:05:36AM Feb 28 14:17:29 volumio startkiosk.sh[696]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Feb 28 14:17:29 volumio startkiosk.sh[696]: Current version of pixman: 0.36.0 Feb 28 14:17:29 volumio startkiosk.sh[696]: Before reporting problems, check http://wiki.x.org Feb 28 14:17:29 volumio startkiosk.sh[696]: to make sure that you have the latest version. Feb 28 14:17:29 volumio startkiosk.sh[696]: Markers: (--) probed, (**) from config file, (==) default setting, Feb 28 14:17:29 volumio startkiosk.sh[696]: (++) from command line, (!!) notice, (II) informational, Feb 28 14:17:29 volumio startkiosk.sh[696]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Feb 28 14:17:29 volumio startkiosk.sh[696]: (==) Log file: "/var/log/Xorg.0.log", Time: Wed Feb 28 14:17:29 2024 Feb 28 14:17:29 volumio startkiosk.sh[696]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Feb 28 14:17:29 volumio dhcpcd[463]: eth0: carrier lost Feb 28 14:17:29 volumio dhcpcd[463]: eth0: carrier lost Feb 28 14:17:29 volumio ifplugd(eth0)[772]: Program executed successfully. Feb 28 14:17:29 volumio ifplugd(eth0)[772]: Link beat lost. Feb 28 14:17:29 volumio ifplugd[719]: Network Interface Plugging Daemon...start eth0...done. Feb 28 14:17:29 volumio systemd[1]: Started LSB: Brings up/down network automatically. Feb 28 14:17:29 volumio startkiosk.sh[696]: gbm: failed to open any driver (search paths /usr/lib/arm-linux-gnueabihf/dri:\$${ORIGIN}/dri:/usr/lib/dri) Feb 28 14:17:29 volumio startkiosk.sh[696]: gbm: Last dlopen error: /usr/lib/dri/rockchip_dri.so: cannot open shared object file: No such file or directory Feb 28 14:17:29 volumio startkiosk.sh[696]: failed to load driver: rockchip Feb 28 14:17:29 volumio nmbd[729]: [2024/02/28 14:17:29.383680, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Feb 28 14:17:29 volumio nmbd[729]: started asyncdns process 810 Feb 28 14:17:29 volumio nmbd[729]: [2024/02/28 14:17:29.385182, 0] ../lib/util/become_daemon.c:149(daemon_status) Feb 28 14:17:29 volumio nmbd[729]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Feb 28 14:17:29 volumio nmbd[729]: [2024/02/28 14:17:29.385306, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Feb 28 14:17:29 volumio nmbd[729]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Feb 28 14:17:29 volumio kernel: cfg80211: World regulatory domain updated: Feb 28 14:17:29 volumio kernel: cfg80211: DFS Master region: unset Feb 28 14:17:29 volumio kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Feb 28 14:17:29 volumio kernel: cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Feb 28 14:17:29 volumio kernel: cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz, 92000 KHz AUTO), (N/A, 2000 mBm), (N/A) Feb 28 14:17:29 volumio kernel: cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Feb 28 14:17:29 volumio kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Feb 28 14:17:29 volumio kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Feb 28 14:17:29 volumio kernel: cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Feb 28 14:17:29 volumio kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Feb 28 14:17:29 volumio kernel: cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Feb 28 14:17:30 volumio ntpd[764]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Feb 28 14:17:30 volumio startkiosk.sh[696]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Feb 28 14:17:31 volumio ntpd[764]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Feb 28 14:17:31 volumio volumio[693]: info: ------------------------------------------- Feb 28 14:17:31 volumio volumio[693]: info: ----- Volumio3 ---- Feb 28 14:17:31 volumio volumio[693]: info: ------------------------------------------- Feb 28 14:17:31 volumio volumio[693]: info: ----- System startup ---- Feb 28 14:17:31 volumio volumio[693]: info: ------------------------------------------- Feb 28 14:17:31 volumio kernel: setLedConfiguration: #### before setting led, Reg26 = 0xd1 , Reg28 = 0x9770 Feb 28 14:17:31 volumio kernel: setLedConfiguration: #### after setting led, Reg26 = 0x91 , Reg28 = 0x9040 Feb 28 14:17:31 volumio kernel: rk_gmac-dwmac ff290000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Feb 28 14:17:31 volumio dhcpcd[463]: eth0: carrier acquired Feb 28 14:17:31 volumio dhcpcd[463]: eth0: carrier acquired Feb 28 14:17:31 volumio dhcpcd[463]: eth0: IAID 64:d8:1c:f9 Feb 28 14:17:31 volumio dhcpcd[463]: eth0: probing address 192.168.1.123/24 Feb 28 14:17:31 volumio dhcpcd[463]: eth0: IAID 64:d8:1c:f9 Feb 28 14:17:31 volumio dhcpcd[463]: eth0: probing address 192.168.1.123/24 Feb 28 14:17:31 volumio ifplugd(eth0)[772]: Link beat detected. Feb 28 14:17:31 volumio volumio[693]: info: MYVOLUMIO Environment detected Feb 28 14:17:32 volumio volumio[693]: info: Plugin folders cleanup Feb 28 14:17:32 volumio volumio[693]: info: Scanning into folder /volumio/app/plugins/ Feb 28 14:17:32 volumio volumio[693]: info: Scanning category audio_interface Feb 28 14:17:32 volumio volumio[693]: info: Scanning category miscellanea Feb 28 14:17:32 volumio volumio[693]: info: Scanning category music_service Feb 28 14:17:32 volumio volumio[693]: info: Scanning category plugins.json Feb 28 14:17:32 volumio volumio[693]: info: Scanning category system_controller Feb 28 14:17:32 volumio dhcpcd[463]: eth0: soliciting an IPv6 router Feb 28 14:17:32 volumio dhcpcd[463]: eth0: soliciting an IPv6 router Feb 28 14:17:32 volumio volumio[693]: info: Scanning category user_interface Feb 28 14:17:32 volumio volumio[693]: info: Scanning into folder /data/plugins/ Feb 28 14:17:32 volumio volumio[693]: info: Scanning category music_service Feb 28 14:17:32 volumio volumio[693]: info: Plugin folders cleanup completed Feb 28 14:17:32 volumio volumio[693]: info: ------------------------------------------- Feb 28 14:17:32 volumio volumio[693]: info: ----- Core plugins startup ---- Feb 28 14:17:32 volumio volumio[693]: info: ------------------------------------------- Feb 28 14:17:32 volumio volumio[693]: info: Loading plugins from folder /volumio/app/plugins/ Feb 28 14:17:32 volumio volumio[693]: info: Adding plugin upnp to MyMusic Plugins Feb 28 14:17:32 volumio volumio[693]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 28 14:17:32 volumio volumio[693]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 28 14:17:32 volumio volumio[693]: info: Loading plugins from folder /data/plugins/ Feb 28 14:17:32 volumio volumio[693]: info: Loading plugin "system"... Feb 28 14:17:32 volumio ntpd[764]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Feb 28 14:17:32 volumio volumio[693]: info: Loading plugin "appearance"... Feb 28 14:17:32 volumio volumio[693]: info: Loading plugin "network"... Feb 28 14:17:32 volumio volumio[693]: info: Refreshing Cached IP Addresses Feb 28 14:17:32 volumio volumio[693]: info: Loading plugin "services"... Feb 28 14:17:32 volumio volumio[693]: info: Loading plugin "alsa_controller"... Feb 28 14:17:32 volumio sudo[885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 28 14:17:32 volumio sudo[885]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:32 volumio sudo[887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 28 14:17:32 volumio sudo[885]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:32 volumio sudo[887]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:32 volumio sudo[887]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:32 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 28 14:17:32 volumio volumio[693]: info: Loading plugin "wizard"... Feb 28 14:17:32 volumio volumio[693]: info: Loading plugin "networkfs"... Feb 28 14:17:32 volumio sudo[911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto horribleroach:/Public\music /mnt/NAS/NAS Feb 28 14:17:33 volumio sudo[913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.12:/Public\music /mnt/NAS/NASS Feb 28 14:17:33 volumio volumio[693]: info: Starting Udev Watcher for removable devices Feb 28 14:17:33 volumio sudo[913]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:33 volumio sudo[911]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:33 volumio sudo[919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=aze,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //192.168.1.12/Public\music /mnt/NAS/192.168.1.12 Feb 28 14:17:33 volumio sudo[920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=aze,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //HORRIBLEROACH/Public\music /mnt/NAS/Hr Feb 28 14:17:33 volumio sudo[919]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:33 volumio sudo[911]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:33 volumio sudo[920]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:33 volumio volumio[693]: info: Ignoring mount for partition: BOOT Feb 28 14:17:33 volumio volumio[693]: info: Ignoring mount for partition: volumio Feb 28 14:17:33 volumio volumio[693]: info: Ignoring mount for partition: volumio_data Feb 28 14:17:33 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 28 14:17:33 volumio volumio[693]: info: Loading plugin "volumio_command_line_client"... Feb 28 14:17:33 volumio sudo[920]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:33 volumio ntpd[764]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Feb 28 14:17:33 volumio volumio[693]: info: Loading plugin "upnp"... Feb 28 14:17:33 volumio kernel: CIFS VFS: Error connecting to socket. Aborting operation. Feb 28 14:17:33 volumio kernel: CIFS VFS: cifs_mount failed w/return code = -101 Feb 28 14:17:33 volumio volumio[693]: info: [1709129853072] Starting Upmpd Daemon Feb 28 14:17:33 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 28 14:17:33 volumio volumio[693]: info: Loading plugin "my_music"... Feb 28 14:17:33 volumio sudo[919]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:33 volumio volumio[693]: info: Loading plugin "mpd"... Feb 28 14:17:33 volumio systemd[1]: systemd-rfkill.service: Succeeded. Feb 28 14:17:33 volumio volumio[693]: info: Loading plugin "upnp_browser"... Feb 28 14:17:33 volumio volumio-remote-updater[468]: [2024-02-28 14:17:33] [connect] Successful connection Feb 28 14:17:33 volumio volumio[693]: info: Loading plugin "alarm-clock"... Feb 28 14:17:33 volumio volumio[693]: info: Loading plugin "airplay_emulation"... Feb 28 14:17:33 volumio volumio[693]: info: Starting Shairport Sync Feb 28 14:17:33 volumio volumio[693]: info: Loading plugin "last_100"... Feb 28 14:17:33 volumio volumio[693]: info: Loading plugin "webradio"... Feb 28 14:17:33 volumio volumio[693]: info: Loading plugin "i2s_dacs"... Feb 28 14:17:33 volumio volumio[693]: info: I2S DAC not set, start Auto-detection Feb 28 14:17:33 volumio volumio[693]: info: Loading plugin "volumiodiscovery"... Feb 28 14:17:33 volumio volumio[693]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 28 14:17:33 volumio volumio[693]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 28 14:17:33 volumio volumio[693]: *** WARNING *** For more information see Feb 28 14:17:33 volumio volumio[693]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 28 14:17:33 volumio volumio[693]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 28 14:17:33 volumio volumio[693]: *** WARNING *** For more information see Feb 28 14:17:33 volumio node[693]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 28 14:17:33 volumio node[693]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 28 14:17:33 volumio node[693]: *** WARNING *** For more information see Feb 28 14:17:33 volumio node[693]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 28 14:17:33 volumio node[693]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 28 14:17:33 volumio node[693]: *** WARNING *** For more information see Feb 28 14:17:33 volumio volumio[693]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 28 14:17:33 volumio volumio[693]: info: Discovery: Started advertising with name: Volumio Feb 28 14:17:33 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 28 14:17:33 volumio volumio[693]: info: Loading plugin "spop"... Feb 28 14:17:34 volumio volumio[693]: info: Loading plugin "youtube2"... Feb 28 14:17:36 volumio dhcpcd[463]: eth0: using static address 192.168.1.123/24 Feb 28 14:17:36 volumio dhcpcd[463]: eth0: adding route to 192.168.1.0/24 Feb 28 14:17:36 volumio dhcpcd[463]: eth0: adding default route via 192.168.1.1 Feb 28 14:17:36 volumio dhcpcd[463]: eth0: using static address 192.168.1.123/24 Feb 28 14:17:36 volumio dhcpcd[463]: eth0: adding route to 192.168.1.0/24 Feb 28 14:17:36 volumio dhcpcd[463]: eth0: adding default route via 192.168.1.1 Feb 28 14:17:36 volumio avahi-daemon[462]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.123. Feb 28 14:17:36 volumio avahi-daemon[462]: New relevant interface eth0.IPv4 for mDNS. Feb 28 14:17:36 volumio avahi-daemon[462]: Registering new address record for 192.168.1.123 on eth0.IPv4. Feb 28 14:17:36 volumio dhcpcd[463]: forked to background, child pid 993 Feb 28 14:17:36 volumio dhcpcd[463]: forked to background, child pid 993 Feb 28 14:17:36 volumio systemd[1]: Started DHCP Client Daemon. Feb 28 14:17:36 volumio sudo[913]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:37 volumio ntpd[764]: Listen normally on 3 eth0 192.168.1.123:123 Feb 28 14:17:37 volumio ntpd[764]: new interface(s) found: waking up resolver Feb 28 14:17:38 volumio volumio[693]: info: Loading plugin "outputs"... Feb 28 14:17:38 volumio volumio[693]: info: Loading plugin "albumart"... Feb 28 14:17:38 volumio volumio[693]: info: Plugin example_plugin is not enabled Feb 28 14:17:38 volumio volumio[693]: info: Loading plugin "inputs"... Feb 28 14:17:38 volumio volumio[693]: info: Loading plugin "updater_comm"... Feb 28 14:17:38 volumio volumio[693]: info: Plugin mpdemulation is not enabled Feb 28 14:17:38 volumio volumio[693]: info: Loading plugin "rest_api"... Feb 28 14:17:38 volumio volumio[693]: info: Loading plugin "websocket"... Feb 28 14:17:38 volumio volumio[693]: info: Loading i18n strings for locale fr Feb 28 14:17:38 volumio volumio[693]: Updating browse sources language Feb 28 14:17:38 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 28 14:17:38 volumio volumio[693]: Forking 3 albumart workers Feb 28 14:17:38 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 28 14:17:38 volumio volumio[693]: info: CoreCommandRouter::initPlayerControls Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 28 14:17:39 volumio volumio[693]: Express server listening on port 3000 Feb 28 14:17:39 volumio volumio[693]: [Metrics] WebUI: 8s 608.60ms Feb 28 14:17:39 volumio volumio[693]: info: CoreStateMachine::resetVolumioState Feb 28 14:17:39 volumio volumio[693]: info: CoreStateMachine::getcurrentVolume Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::volumioRetrievevolume Feb 28 14:17:39 volumio volumio[693]: info: CoreStateMachine::pushState Feb 28 14:17:39 volumio volumio[693]: info: CorePlayQueue::getTrack 0 Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::volumioPushState Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 28 14:17:39 volumio volumio[693]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 28 14:17:39 volumio volumio[693]: info: Completed loading Core Plugins Feb 28 14:17:39 volumio volumio[693]: info: Preparing to generate the ALSA configuration file Feb 28 14:17:39 volumio volumio[693]: info: Cannot mount NAS Hr at system boot, trial number 1 ,retrying in 5 seconds Feb 28 14:17:39 volumio volumio[693]: info: Cannot mount NAS 192.168.1.12 at system boot, trial number 1 ,retrying in 5 seconds Feb 28 14:17:39 volumio volumio[693]: info: Cannot mount NAS NASS at system boot, trial number 1 ,retrying in 5 seconds Feb 28 14:17:39 volumio volumio[693]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Feb 28 14:17:39 volumio kernel: nf_conntrack: automatic helper assignment is deprecated and it will be removed soon. Use the iptables CT target to attach helpers instead. Feb 28 14:17:39 volumio volumio[693]: info: Reloading queue from file Feb 28 14:17:39 volumio nmbd[729]: [2024/02/28 14:17:39.431518, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 28 14:17:39 volumio systemd[1]: Started Samba NMB Daemon. Feb 28 14:17:39 volumio nmbd[729]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Feb 28 14:17:39 volumio systemd[1]: Starting Samba Winbind Daemon... Feb 28 14:17:39 volumio volumio[693]: info: CoreStateMachine::setRepeat false single undefined Feb 28 14:17:39 volumio volumio[693]: info: CoreStateMachine::pushState Feb 28 14:17:39 volumio volumio[693]: info: CorePlayQueue::getTrack 0 Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::volumioPushState Feb 28 14:17:39 volumio volumio[693]: info: CoreStateMachine::setRandom false Feb 28 14:17:39 volumio volumio[693]: info: CoreStateMachine::pushState Feb 28 14:17:39 volumio volumio[693]: info: CorePlayQueue::getTrack 0 Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::volumioPushState Feb 28 14:17:39 volumio volumio[693]: info: Setting Device type: Tinkerboard Feb 28 14:17:39 volumio volumio[693]: info: Asound.conf file written Feb 28 14:17:39 volumio sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 28 14:17:39 volumio sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:39 volumio sudo[1143]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:39 volumio volumio[693]: Starting albumart workers Feb 28 14:17:39 volumio volumio[693]: info: Output device has changed, restarting MPD Feb 28 14:17:39 volumio volumio[693]: Starting albumart workers Feb 28 14:17:39 volumio volumio[693]: info: Output device has changed, restarting Shairport Sync Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:39 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 28 14:17:40 volumio sudo[1173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 28 14:17:40 volumio sudo[1171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 28 14:17:40 volumio sudo[1171]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:40 volumio sudo[1173]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:40 volumio volumio[693]: info: ___________ START PLUGINS ___________ Feb 28 14:17:40 volumio sudo[1171]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:40 volumio volumio[693]: info: ControllerMpd::onStart: Initializing MPD Feb 28 14:17:40 volumio volumio[693]: info: Creating MPD Configuration file Feb 28 14:17:40 volumio winbindd[1130]: [2024/02/28 14:17:40.119464, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Feb 28 14:17:40 volumio winbindd[1130]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 28 14:17:40 volumio winbindd[1130]: [2024/02/28 14:17:40.134374, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 28 14:17:40 volumio systemd[1]: Started Samba Winbind Daemon. Feb 28 14:17:40 volumio winbindd[1130]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Feb 28 14:17:40 volumio systemd[1]: Starting Samba SMB Daemon... Feb 28 14:17:40 volumio sudo[1200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 28 14:17:40 volumio volumio[693]: info: [1709129860215] CoreMusicLibrary::Adding element Serveurs Média Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 28 14:17:40 volumio systemd[1]: Listening on mpd.socket. Feb 28 14:17:40 volumio systemd[1]: Starting Music Player Daemon... Feb 28 14:17:40 volumio sudo[1200]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:40 volumio sudo[1200]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 28 14:17:40 volumio sudo[1208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 28 14:17:40 volumio sudo[1208]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 28 14:17:40 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 28 14:17:40 volumio systemd[1]: mpd.service: Succeeded. Feb 28 14:17:40 volumio systemd[1]: Stopped Music Player Daemon. Feb 28 14:17:40 volumio systemd[1]: Starting Music Player Daemon... Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 28 14:17:40 volumio volumio[693]: info: [1709129860529] CoreMusicLibrary::Adding element Last_100 Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 28 14:17:40 volumio volumio[693]: info: [1709129860532] CoreMusicLibrary::Adding element Webradio Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 28 14:17:40 volumio volumio[693]: info: Checking for old spotify connect plugin installed Feb 28 14:17:40 volumio volumio[693]: info: [youtube2-auth] Starting auth flow... Feb 28 14:17:40 volumio volumio[693]: Starting albumart workers Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 28 14:17:40 volumio volumio[693]: info: [1709129860732] CoreMusicLibrary::Adding element YouTube2 Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 28 14:17:40 volumio volumio[693]: Cannot find translation for source YouTube2 Feb 28 14:17:40 volumio volumio[693]: info: Volumio Calling Home Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 28 14:17:40 volumio volumio[693]: [SpotifyConnect] Creating VLS config file Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:40 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:40 volumio volumio[693]: [SpotifyConnect] Starting metadata listener Feb 28 14:17:41 volumio winbindd[1130]: [2024/02/28 14:17:41.057088, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Feb 28 14:17:41 volumio winbindd[1130]: res_names->count = 3, expected 4 Feb 28 14:17:41 volumio sudo[1270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Feb 28 14:17:41 volumio volumio[693]: info: Volumio called home Feb 28 14:17:41 volumio volumio[693]: info: MPD Permissions set Feb 28 14:17:41 volumio volumio[693]: info: MPD Permissions set Feb 28 14:17:41 volumio sudo[1270]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 28 14:17:41 volumio volumio[693]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 Feb 28 14:17:41 volumio volumio[693]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Feb 28 14:17:41 volumio smbd[1206]: [2024/02/28 14:17:41.137022, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 28 14:17:41 volumio systemd[1]: Started Samba SMB Daemon. Feb 28 14:17:41 volumio smbd[1206]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 28 14:17:41 volumio systemd[1]: Reached target Multi-User System. Feb 28 14:17:41 volumio systemd[1]: Reached target Graphical Interface. Feb 28 14:17:41 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio systemd[1]: Started Volspotconnect2 Daemon. Feb 28 14:17:41 volumio sudo[1270]: pam_unix(sudo:session): session closed for user root Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 28 14:17:41 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 28 14:17:41 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[1292]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Feb 28 14:17:41 volumio volumio[1292]: Reading Config from "/tmp/volspotify.toml" Feb 28 14:17:41 volumio volumio[1292]: [Vollibrespot] : Using Alsa backend with device: volumio Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 28 14:17:41 volumio volumio[693]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 28 14:17:41 volumio volumio[1292]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Feb 28 14:17:41 volumio volumio[693]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 28 14:17:41 volumio volumio[693]: ReferenceError: deferred is not defined Feb 28 14:17:41 volumio volumio[693]: at ClientRequest. (/data/plugins/music_service/youtube2/lib/core/gapi/auth.js:155:13) Feb 28 14:17:41 volumio volumio[693]: at ClientRequest.emit (events.js:400:28) Feb 28 14:17:41 volumio volumio[693]: at TLSSocket.socketErrorListener (_http_client.js:475:9) Feb 28 14:17:41 volumio volumio[693]: at TLSSocket.emit (events.js:400:28) Feb 28 14:17:41 volumio volumio[693]: at emitErrorNT (internal/streams/destroy.js:106:8) Feb 28 14:17:41 volumio volumio[693]: at emitErrorCloseNT (internal/streams/destroy.js:74:3) Feb 28 14:17:41 volumio volumio[693]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Feb 28 14:17:41 volumio volumio[693]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 28 14:17:41 volumio volumio[1292]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443" Feb 28 14:17:41 volumio volumio[1292]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /build/cache/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 Feb 28 14:17:41 volumio volumio[1292]: stack backtrace: Feb 28 14:17:41 volumio volumio[1292]: 0: 0x7fb51444 - std::backtrace_rs::backtrace::libunwind::trace::h40a4eff66330a36d Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 Feb 28 14:17:41 volumio volumio[1292]: 1: 0x7fb51444 - std::backtrace_rs::backtrace::trace_unsynchronized::hbce01963451b0cd5 Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 Feb 28 14:17:41 volumio volumio[1292]: 2: 0x7fb51444 - std::sys_common::backtrace::_print_fmt::h95da650d09c7e00b Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5 Feb 28 14:17:41 volumio volumio[1292]: 3: 0x7fb51444 - ::fmt::h33b23b1d14f668ff Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22 Feb 28 14:17:41 volumio volumio[1292]: 4: 0x7fb7a0dc - core::fmt::write::h6320fb0e6ac90e58 Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17 Feb 28 14:17:41 volumio volumio[1292]: 5: 0x7fb494c4 - std::io::Write::write_fmt::h33b25d4810ca481f Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15 Feb 28 14:17:41 volumio volumio[1292]: 6: 0x7fb53ef4 - std::sys_common::backtrace::_print::h7e61c5be69c715ef Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5 Feb 28 14:17:41 volumio volumio[1292]: 7: 0x7fb53ef4 - std::sys_common::backtrace::print::h3cee176d7c8dab8b Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9 Feb 28 14:17:41 volumio volumio[1292]: 8: 0x7fb53ef4 - std::panicking::default_hook::{{closure}}::h2d0211dd2e97dc43 Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22 Feb 28 14:17:41 volumio volumio[1292]: 9: 0x7fb53b14 - std::panicking::default_hook::hcbdb3b7c40dca30c Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:314:9 Feb 28 14:17:41 volumio volumio[1292]: 10: 0x7fb54694 - std::panicking::rust_panic_with_hook::h4ce49e7a343dc12b Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17 Feb 28 14:17:41 volumio volumio[1292]: 11: 0x7fb54304 - std::panicking::begin_panic_handler::{{closure}}::h4961100fae529fe9 Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13 Feb 28 14:17:41 volumio volumio[1292]: 12: 0x7fb519c4 - std::sys_common::backtrace::__rust_end_short_backtrace::hf2e68e62c7a80f1f Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18 Feb 28 14:17:41 volumio volumio[1292]: 13: 0x7fb54098 - rust_begin_unwind Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5 Feb 28 14:17:41 volumio volumio[1292]: 14: 0x7f6376f4 - core::panicking::panic_fmt::h84c42730e4a50809 Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14 Feb 28 14:17:41 volumio volumio[1292]: 15: 0x7f823930 - futures::future::chain::Chain::poll::hb08394d341f2da5e Feb 28 14:17:41 volumio volumio[1292]: 16: 0x7f8a1d4c - as futures::future::Future>::poll::h0222f8b810b74ccb Feb 28 14:17:41 volumio volumio[1292]: 17: 0x7f82453c - futures::future::chain::Chain::poll::hd3215a5f3268adbc Feb 28 14:17:41 volumio volumio[1292]: 18: 0x7f89a5f0 - as futures::future::Future>::poll::hc28eaa01d8d9029a Feb 28 14:17:41 volumio volumio[1292]: 19: 0x7f65eb34 - ::poll::h5fd9e3bcdeb25ad9 Feb 28 14:17:41 volumio volumio[1292]: 20: 0x7f67c3dc - futures::task_impl::std::set::h8f754e80bd562d0a Feb 28 14:17:41 volumio volumio[1292]: 21: 0x7f69342c - std::thread::local::LocalKey::with::h71cfa1e374fcc0a0 Feb 28 14:17:41 volumio volumio[1292]: 22: 0x7f67899c - tokio_current_thread::Entered

::block_on::hde55cdf28eabe6d5 Feb 28 14:17:41 volumio volumio[1292]: 23: 0x7f6936f0 - std::thread::local::LocalKey::with::hedba3cfe41326627 Feb 28 14:17:41 volumio volumio[1292]: 24: 0x7f67b880 - tokio::runtime::current_thread::runtime::Runtime::block_on::h60d5b89560100ed8 Feb 28 14:17:41 volumio volumio[1292]: 25: 0x7f661eb0 - vollibrespot::main::h35555355ed947dd1 Feb 28 14:17:41 volumio volumio[1292]: 26: 0x7f681c50 - std::sys_common::backtrace::__rust_begin_short_backtrace::hef626a10d324c12a Feb 28 14:17:41 volumio volumio[1292]: 27: 0x7f6a752c - std::rt::lang_start::{{closure}}::hd80188e4bcac5072 Feb 28 14:17:41 volumio volumio[1292]: 28: 0x7fb50b28 - core::ops::function::impls:: for &F>::call_once::h0567da839a080232 Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:259:13 Feb 28 14:17:41 volumio volumio[1292]: 29: 0x7fb50b28 - std::panicking::try::do_call::hdf194554a41aa3cc Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 Feb 28 14:17:41 volumio volumio[1292]: 30: 0x7fb50b28 - std::panicking::try::hbf4b7be9f9ffa5f8 Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 Feb 28 14:17:41 volumio volumio[1292]: 31: 0x7fb50b28 - std::panic::catch_unwind::h45f392a39f2fe48c Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 Feb 28 14:17:41 volumio volumio[1292]: 32: 0x7fb50b28 - std::rt::lang_start_internal::{{closure}}::hd772cb03c2060671 Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:48 Feb 28 14:17:41 volumio volumio[1292]: 33: 0x7fb50b28 - std::panicking::try::do_call::hd126f715b519ff2a Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40 Feb 28 14:17:41 volumio volumio[1292]: 34: 0x7fb50b28 - std::panicking::try::h80b7148ce71893dc Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19 Feb 28 14:17:41 volumio volumio[1292]: 35: 0x7fb50b28 - std::panic::catch_unwind::h1562f0b2e8a9cb0d Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14 Feb 28 14:17:41 volumio volumio[1292]: 36: 0x7fb50b28 - std::rt::lang_start_internal::h3daa586a0b835507 Feb 28 14:17:41 volumio volumio[1292]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:20 Feb 28 14:17:41 volumio volumio[1292]: 37: 0x7f663e80 - main Feb 28 14:17:41 volumio volumio[1292]: 38: 0xb6c99524 - __libc_start_main Feb 28 14:17:41 volumio systemd[1]: volspotconnect.service: Main process exited, code=exited, status=101/n/a Feb 28 14:17:41 volumio systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Feb 28 14:17:41 volumio sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-02-28 14:16 Feb 28 14:17:41 volumio sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e831866afe2db61aee9333a8f5ba9d9fd36609c7" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 18 Feb 2024 11:15:21 AM CET" VOLUMIO_VERSION="3.629" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="293a767fd1b71cabc5f5be4916f770a0"