-- 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"