-- Logs begin at Mon 2026-02-23 05:01:59 CET, end at Mon 2026-02-23 05:03:02 CET. -- Feb 23 05:02:00 Sypialnia systemd-udevd[380]: Using default interface naming scheme 'v240'. Feb 23 05:02:00 Sypialnia systemd-udevd[380]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 23 05:02:00 Sypialnia systemd-udevd[380]: link_config: could not get ethtool features for eth0 Feb 23 05:02:00 Sypialnia systemd-udevd[380]: Could not set offload features of eth0: Device or resource busy Feb 23 05:02:00 Sypialnia kernel: RTL871X: module init start Feb 23 05:02:00 Sypialnia kernel: RTL871X: rtl8812au v4.3.14_13455.20150212_BTCOEX20150128-51 Feb 23 05:02:00 Sypialnia kernel: RTL871X: rtl8812au BT-Coex version = BTCOEX20150128-51 Feb 23 05:02:00 Sypialnia systemd[1]: Found device /dev/ttyS3. Feb 23 05:02:00 Sypialnia systemd-udevd[375]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 23 05:02:00 Sypialnia systemd-udevd[371]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 23 05:02:00 Sypialnia systemd-udevd[375]: Using default interface naming scheme 'v240'. Feb 23 05:02:00 Sypialnia systemd-udevd[375]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 23 05:02:00 Sypialnia kernel: rtl8723bs mmc2:0001:1 wlan1: renamed from wlan0 Feb 23 05:02:00 Sypialnia systemd-udevd[373]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 05:02:00 Sypialnia systemd[1]: Found device /dev/disk/by-uuid/287B-56ED. Feb 23 05:02:00 Sypialnia systemd-udevd[377]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 05:02:00 Sypialnia kernel: cfg80211: World regulatory domain updated: Feb 23 05:02:00 Sypialnia kernel: cfg80211: DFS Master region: unset Feb 23 05:02:00 Sypialnia kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz, 92000 KHz AUTO), (N/A, 2000 mBm), (N/A) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Feb 23 05:02:00 Sypialnia kernel: cfg80211: Regulatory domain changed to country: PL Feb 23 05:02:00 Sypialnia kernel: cfg80211: DFS Master region: ETSI Feb 23 05:02:00 Sypialnia kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2700 mBm), (0 s) Feb 23 05:02:00 Sypialnia kernel: cfg80211: (57000000 KHz - 66000000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A) Feb 23 05:02:00 Sypialnia systemd-udevd[370]: Using default interface naming scheme 'v240'. Feb 23 05:02:00 Sypialnia systemd-udevd[377]: Using default interface naming scheme 'v240'. Feb 23 05:02:00 Sypialnia systemd-udevd[377]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 23 05:02:00 Sypialnia kernel: RTL871X: rtw_ndev_init(wlan0) Feb 23 05:02:00 Sypialnia kernel: usbcore: registered new interface driver rtl8812au Feb 23 05:02:00 Sypialnia kernel: RTL871X: module init ret=0 Feb 23 05:02:00 Sypialnia systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Feb 23 05:02:00 Sypialnia systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Feb 23 05:02:00 Sypialnia systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Feb 23 05:02:00 Sypialnia systemd[1]: Condition check resulted in Huge Pages File System being skipped. Feb 23 05:02:00 Sypialnia systemd[1]: Starting Show Plymouth Boot Screen... Feb 23 05:02:00 Sypialnia systemd[1]: Condition check resulted in Arbitrary Executable File Formats File System Automount Point being skipped. Feb 23 05:02:00 Sypialnia systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Feb 23 05:02:00 Sypialnia systemd[1]: Starting File System Check on /dev/disk/by-uuid/287B-56ED... Feb 23 05:02:00 Sypialnia systemd[1]: Starting Load/Save RF Kill Switch Status... Feb 23 05:02:00 Sypialnia systemd[1]: Started File System Check Daemon to report status. Feb 23 05:02:00 Sypialnia systemd[1]: plymouth-start.service: Succeeded. Feb 23 05:02:00 Sypialnia systemd[1]: Started Show Plymouth Boot Screen. Feb 23 05:02:00 Sypialnia systemd[1]: Found device RTL8812AU 802.11a/b/g/n/ac 2T2R DB WLAN Adapter. Feb 23 05:02:00 Sypialnia systemd[1]: Started Load/Save RF Kill Switch Status. Feb 23 05:02:00 Sypialnia systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Feb 23 05:02:00 Sypialnia systemd-fsck[490]: fsck.fat 4.1 (2017-01-24) Feb 23 05:02:00 Sypialnia systemd-fsck[490]: /dev/mmcblk1p1: 91 files, 10749/30651 clusters Feb 23 05:02:00 Sypialnia systemd[1]: Started File System Check on /dev/disk/by-uuid/287B-56ED. Feb 23 05:02:00 Sypialnia systemd[1]: Mounting /boot... Feb 23 05:02:00 Sypialnia systemd[1]: Mounted /boot. Feb 23 05:02:00 Sypialnia systemd[1]: Reached target Local File Systems. Feb 23 05:02:00 Sypialnia systemd[1]: Starting Preprocess NFS configuration... Feb 23 05:02:00 Sypialnia systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Feb 23 05:02:00 Sypialnia systemd[1]: Started ifup for eth0. Feb 23 05:02:00 Sypialnia systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Feb 23 05:02:00 Sypialnia systemd[1]: Starting Create Volatile Files and Directories... Feb 23 05:02:00 Sypialnia systemd[1]: Started ifup for wlan0. Feb 23 05:02:00 Sypialnia systemd[1]: Received SIGRTMIN+20 from PID 230 (plymouthd). Feb 23 05:02:00 Sypialnia systemd[1]: nfs-config.service: Succeeded. Feb 23 05:02:00 Sypialnia systemd[1]: Started Preprocess NFS configuration. Feb 23 05:02:00 Sypialnia systemd[1]: plymouth-read-write.service: Succeeded. Feb 23 05:02:00 Sypialnia systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Feb 23 05:02:00 Sypialnia systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Feb 23 05:02:00 Sypialnia systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Feb 23 05:02:00 Sypialnia systemd[1]: Reached target NFS client services. Feb 23 05:02:00 Sypialnia systemd[1]: Started Create Volatile Files and Directories. Feb 23 05:02:00 Sypialnia systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Feb 23 05:02:00 Sypialnia systemd[1]: Starting Update UTMP about System Boot/Shutdown... Feb 23 05:02:00 Sypialnia systemd[1]: Starting RPC bind portmap service... Feb 23 05:02:00 Sypialnia systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Feb 23 05:02:00 Sypialnia systemd[1]: Started Update UTMP about System Boot/Shutdown. Feb 23 05:02:00 Sypialnia systemd[1]: Reached target System Initialization. Feb 23 05:02:00 Sypialnia systemd[1]: Started Daily Cleanup of Temporary Directories. Feb 23 05:02:00 Sypialnia systemd[1]: Listening on D-Bus System Message Bus Socket. Feb 23 05:02:00 Sypialnia systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Feb 23 05:02:00 Sypialnia systemd[1]: Started Daily man-db regeneration. Feb 23 05:02:00 Sypialnia systemd[1]: Started Daily apt download activities. Feb 23 05:02:00 Sypialnia systemd[1]: Started Daily apt upgrade and clean activities. Feb 23 05:02:00 Sypialnia systemd[1]: Reached target Timers. Feb 23 05:02:00 Sypialnia systemd[1]: Listening on triggerhappy.socket. Feb 23 05:02:00 Sypialnia systemd[1]: Reached target Sockets. Feb 23 05:02:00 Sypialnia systemd[1]: Reached target Basic System. Feb 23 05:02:00 Sypialnia systemd[1]: Started Volumio Log Rotation Service. Feb 23 05:02:00 Sypialnia systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Feb 23 05:02:00 Sypialnia systemd[1]: Starting DHCP Client Daemon... Feb 23 05:02:00 Sypialnia systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Feb 23 05:02:00 Sypialnia systemd[1]: Started D-Bus System Message Bus. Feb 23 05:02:00 Sypialnia systemd[1]: Starting triggerhappy global hotkey daemon... Feb 23 05:02:00 Sypialnia systemd[1]: Started Tinkerboard BT INIT. Feb 23 05:02:00 Sypialnia systemd[1]: Starting Volumio Time Update Utility... Feb 23 05:02:00 Sypialnia systemd[1]: Started UPnP Renderer front-end to MPD. Feb 23 05:02:00 Sypialnia systemd[1]: Started Manage Sound Card State (restore and store). Feb 23 05:02:00 Sypialnia systemd[1]: Starting Login Service... Feb 23 05:02:00 Sypialnia thd[547]: Unable to parse trigger line: Feb 23 05:02:00 Sypialnia thd[547]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Feb 23 05:02:00 Sypialnia thd[547]: Unable to parse trigger line: Feb 23 05:02:00 Sypialnia thd[547]: Unable to parse trigger line: Feb 23 05:02:00 Sypialnia thd[547]: Found socket passed from systemd Feb 23 05:02:00 Sypialnia alsactl[553]: alsactl 1.1.8 daemon started Feb 23 05:02:00 Sypialnia systemd[1]: Started volumio-remote-updater.service. Feb 23 05:02:01 Sypialnia kernel: ttyS0 - failed to request DMA Feb 23 05:02:01 Sypialnia systemd[1]: Starting Save/Restore Sound Card State... Feb 23 05:02:01 Sypialnia systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Feb 23 05:02:01 Sypialnia volumio-time-update[549]: volumio-time-update-util: Fetching time from Volumio... Feb 23 05:02:01 Sypialnia systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Feb 23 05:02:01 Sypialnia systemd[1]: Starting Wireless Services... Feb 23 05:02:01 Sypialnia systemd[1]: Started Volumio Iptables Module. Feb 23 05:02:01 Sypialnia systemd[1]: Starting WPA supplicant... Feb 23 05:02:01 Sypialnia systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Feb 23 05:02:01 Sypialnia systemd[1]: Started triggerhappy global hotkey daemon. Feb 23 05:02:01 Sypialnia systemd-logind[557]: New seat seat0. Feb 23 05:02:01 Sypialnia systemd-logind[557]: Watching system buttons on /dev/input/event1 (RC for dw_hdmi) Feb 23 05:02:01 Sypialnia systemd-logind[557]: Watching system buttons on /dev/input/event2 (gpio-keys) Feb 23 05:02:01 Sypialnia systemd[1]: Started Login Service. Feb 23 05:02:01 Sypialnia systemd[1]: Started Save/Restore Sound Card State. Feb 23 05:02:01 Sypialnia systemd[1]: Reached target Sound Card. Feb 23 05:02:01 Sypialnia avahi-daemon[561]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Feb 23 05:02:01 Sypialnia avahi-daemon[561]: Successfully dropped root privileges. Feb 23 05:02:01 Sypialnia avahi-daemon[561]: avahi-daemon 0.7 starting up. Feb 23 05:02:01 Sypialnia systemd[1]: Started Avahi mDNS/DNS-SD Stack. Feb 23 05:02:01 Sypialnia avahi-daemon[561]: Successfully called chroot(). Feb 23 05:02:01 Sypialnia avahi-daemon[561]: Successfully dropped remaining capabilities. Feb 23 05:02:01 Sypialnia avahi-daemon[561]: Loading service file /services/smb.service. Feb 23 05:02:01 Sypialnia avahi-daemon[561]: Loading service file /services/volumio.service. Feb 23 05:02:01 Sypialnia systemd[1]: Started WPA supplicant. Feb 23 05:02:01 Sypialnia wpa_supplicant[568]: Successfully initialized wpa_supplicant Feb 23 05:02:01 Sypialnia systemd[1]: iptables.service: Succeeded. Feb 23 05:02:01 Sypialnia volumio-remote-updater[558]: Error: No active session Feb 23 05:02:01 Sypialnia volumio-time-update[549]: volumio-time-update-util: Date not found in response Feb 23 05:02:01 Sypialnia volumio-time-update[549]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 05:02:01 Sypialnia volumio[552]: Could not open config: /tmp/upmpdcli.conf Feb 23 05:02:01 Sypialnia systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 23 05:02:01 Sypialnia systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 23 05:02:01 Sypialnia systemd[1]: Started RPC bind portmap service. Feb 23 05:02:01 Sypialnia systemd[1]: Reached target Remote File Systems (Pre). Feb 23 05:02:01 Sypialnia systemd[1]: Reached target Remote File Systems. Feb 23 05:02:01 Sypialnia kernel: IPVS: Creating netns size=1496 id=1 Feb 23 05:02:01 Sypialnia kernel: IPVS: ftp: loaded support on port[0] = 21 Feb 23 05:02:01 Sypialnia avahi-daemon[561]: Network interface enumeration completed. Feb 23 05:02:01 Sypialnia systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Feb 23 05:02:01 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:01] [info] asio async_connect error: system:111 (Connection refused) Feb 23 05:02:01 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 23 05:02:01 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:01] [error] handle_connect error: Underlying Transport Error Feb 23 05:02:01 Sypialnia avahi-daemon[561]: Server startup complete. Host name is Sypialnia.local. Local service cookie is 3924055428. Feb 23 05:02:01 Sypialnia systemd[1]: Reached target RPC Port Mapper. Feb 23 05:02:01 Sypialnia avahi-daemon[561]: Service "Sypialnia" (/services/volumio.service) successfully established. Feb 23 05:02:01 Sypialnia avahi-daemon[561]: Service "Sypialnia" (/services/smb.service) successfully established. Feb 23 05:02:01 Sypialnia kernel: rtk_btcoex: Open BTCOEX Feb 23 05:02:01 Sypialnia kernel: rtk_btcoex: create_udpsocket: connect_port: 30001 Feb 23 05:02:01 Sypialnia kernel: rtk_btcoex: send msg INVITE_REQ with len:11 Feb 23 05:02:01 Sypialnia dhcpcd[543]: no interfaces have a carrier Feb 23 05:02:01 Sypialnia dhcpcd[543]: no interfaces have a carrier Feb 23 05:02:01 Sypialnia dhcpcd[543]: forked to background, child pid 673 Feb 23 05:02:01 Sypialnia dhcpcd[543]: forked to background, child pid 673 Feb 23 05:02:01 Sypialnia systemd[1]: Started DHCP Client Daemon. Feb 23 05:02:01 Sypialnia kernel: Bluetooth: Out-of-order packet arrived (7 != 0) Feb 23 05:02:01 Sypialnia systemd[1]: Starting Bluetooth service... Feb 23 05:02:01 Sypialnia sh[505]: wlan0=wlan0 Feb 23 05:02:01 Sypialnia loadcpufreq[598]: Loading cpufreq kernel modules...done (none). Feb 23 05:02:01 Sypialnia systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Feb 23 05:02:01 Sypialnia systemd[1]: Starting LSB: set CPUFreq kernel parameters... Feb 23 05:02:01 Sypialnia bluetoothd[679]: Bluetooth daemon 5.83 Feb 23 05:02:01 Sypialnia bluetoothd[679]: src/main.c:check_options() Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Feb 23 05:02:01 Sypialnia systemd[1]: Started Bluetooth service. Feb 23 05:02:01 Sypialnia systemd[1]: Reached target Bluetooth. Feb 23 05:02:01 Sypialnia bluetoothd[679]: Starting SDP server Feb 23 05:02:01 Sypialnia bluetoothd[679]: Excluding (cli) hostname Feb 23 05:02:01 Sypialnia bluetoothd[679]: Excluding (cli) scanparam Feb 23 05:02:01 Sypialnia bluetoothd[679]: Excluding (cli) battery Feb 23 05:02:01 Sypialnia bluetoothd[679]: profiles/network/bnep.c:bnep_init() kernel lacks bnep-protocol support Feb 23 05:02:01 Sypialnia bluetoothd[679]: Bluetooth management interface 1.10 initialized Feb 23 05:02:01 Sypialnia dhcpcd[673]: eth0: waiting for carrier Feb 23 05:02:01 Sypialnia sh[500]: eth0: waiting for carrier Feb 23 05:02:01 Sypialnia dhcpcd[536]: eth0: waiting for carrier Feb 23 05:02:01 Sypialnia sh[500]: eth0: carrier acquired Feb 23 05:02:01 Sypialnia dhcpcd[536]: eth0: carrier acquired Feb 23 05:02:01 Sypialnia kernel: Bluetooth: Out-of-order packet arrived (7 != 0) Feb 23 05:02:01 Sypialnia cpufrequtils[690]: CPUFreq Utilities: Setting conservative CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Feb 23 05:02:01 Sypialnia systemd[1]: Started LSB: set CPUFreq kernel parameters. Feb 23 05:02:01 Sypialnia kernel: rtk_btcoex: BTCOEX hci_rev 0x1e3e Feb 23 05:02:01 Sypialnia kernel: rtk_btcoex: BTCOEX lmp_subver 0xe40e Feb 23 05:02:01 Sypialnia bluetoothd[679]: src/adapter.c:reset_adv_monitors_complete() Failed to reset Adv Monitors: Unknown Command (0x01) Feb 23 05:02:01 Sypialnia bluetoothd[679]: Battery Provider Manager created Feb 23 05:02:02 Sypialnia kernel: cgroup: new mount options do not match the existing superblock, will be ignored Feb 23 05:02:02 Sypialnia volumio[544]: cset: --> shielding system active with Feb 23 05:02:02 Sypialnia volumio[544]: cset: "system" cpuset of CPUSPEC(1-3) with 56 tasks running Feb 23 05:02:02 Sypialnia volumio[544]: cset: "user" cpuset of CPUSPEC(0) with 0 tasks running Feb 23 05:02:02 Sypialnia systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Feb 23 05:02:02 Sypialnia kernel: usbcore: registered new interface driver snd-usb-audio Feb 23 05:02:02 Sypialnia systemd-udevd[377]: Process '/bin/bash -c '/usr/local/bin/volumio scanaudioinputs'' failed with exit code 7. Feb 23 05:02:02 Sypialnia wireless.js[564]: Cleaning previous... Feb 23 05:02:02 Sypialnia systemd-udevd[368]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 23 05:02:02 Sypialnia systemd-logind[557]: Watching system buttons on /dev/input/event0 (Generic USB Audio) Feb 23 05:02:02 Sypialnia systemd[1]: Started Helper to synchronize boot up for ifupdown. Feb 23 05:02:02 Sypialnia systemd[1]: Starting Raise network interfaces... Feb 23 05:02:03 Sypialnia dhcpcd[673]: wlan1: waiting for carrier Feb 23 05:02:03 Sypialnia dhcpcd[673]: wlan0: waiting for carrier Feb 23 05:02:03 Sypialnia dhcpcd[673]: eth0: carrier acquired Feb 23 05:02:03 Sypialnia dhcpcd[673]: DUID 00:01:00:01:2b:b8:6e:fc:3c:7c:3f:cd:b1:d1 Feb 23 05:02:03 Sypialnia dhcpcd[673]: eth0: IAID 3f:cd:b1:d1 Feb 23 05:02:03 Sypialnia dhcpcd[673]: eth0: adding address fe80::3e7c:3fff:fecd:b1d1 Feb 23 05:02:03 Sypialnia dhcpcd[673]: ipv6_addaddr1: Permission denied Feb 23 05:02:03 Sypialnia sh[500]: DUID 00:01:00:01:2b:b8:6e:fc:3c:7c:3f:cd:b1:d1 Feb 23 05:02:03 Sypialnia sh[500]: eth0: IAID 3f:cd:b1:d1 Feb 23 05:02:03 Sypialnia sh[500]: eth0: adding address fe80::3e7c:3fff:fecd:b1d1 Feb 23 05:02:03 Sypialnia sh[500]: ipv6_addaddr1: Permission denied Feb 23 05:02:03 Sypialnia dhcpcd[536]: DUID 00:01:00:01:2b:b8:6e:fc:3c:7c:3f:cd:b1:d1 Feb 23 05:02:03 Sypialnia dhcpcd[536]: eth0: IAID 3f:cd:b1:d1 Feb 23 05:02:03 Sypialnia dhcpcd[536]: eth0: adding address fe80::3e7c:3fff:fecd:b1d1 Feb 23 05:02:03 Sypialnia dhcpcd[536]: ipv6_addaddr1: Permission denied Feb 23 05:02:03 Sypialnia sudo[739]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 23 05:02:03 Sypialnia sudo[739]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:03 Sypialnia sudo[739]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:03 Sypialnia haveged[540]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.3.0 CTV); collect: 128K Feb 23 05:02:03 Sypialnia haveged[540]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 12/40; sz: 15012/57848 Feb 23 05:02:03 Sypialnia haveged[540]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00024 Feb 23 05:02:03 Sypialnia haveged[540]: haveged: fills: 0, generated: 0 Feb 23 05:02:03 Sypialnia sudo[779]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Feb 23 05:02:03 Sypialnia sudo[779]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:03 Sypialnia sudo[779]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:03 Sypialnia systemd[1]: Started Raise network interfaces. Feb 23 05:02:03 Sypialnia systemd[1]: Reached target Network. Feb 23 05:02:03 Sypialnia systemd[1]: Starting Network Time Service... Feb 23 05:02:03 Sypialnia systemd[1]: Reached target Network is Online. Feb 23 05:02:03 Sypialnia systemd[1]: Starting LSB: Brings up/down network automatically... Feb 23 05:02:03 Sypialnia systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 05:02:03 Sypialnia systemd[1]: Started Volumio Restarter Service. Feb 23 05:02:03 Sypialnia systemd[1]: Starting /etc/rc.local Compatibility... Feb 23 05:02:03 Sypialnia systemd[1]: Starting Permit User Sessions... Feb 23 05:02:03 Sypialnia systemd[1]: Starting Samba NMB Daemon... Feb 23 05:02:03 Sypialnia systemd[1]: Starting OpenBSD Secure Shell server... Feb 23 05:02:03 Sypialnia systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Feb 23 05:02:03 Sypialnia ntpd[822]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 23 05:02:03 Sypialnia ntpd[822]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Feb 23 05:02:03 Sypialnia systemd[1]: Started Network Time Service. Feb 23 05:02:03 Sypialnia wireless.js[564]: Stopped aP Feb 23 05:02:03 Sypialnia systemd[1]: Started Permit User Sessions. Feb 23 05:02:03 Sypialnia sh[500]: eth0: soliciting an IPv6 router Feb 23 05:02:03 Sypialnia dhcpcd[536]: eth0: soliciting an IPv6 router Feb 23 05:02:03 Sypialnia ntpd[851]: proto: precision = 0.583 usec (-21) Feb 23 05:02:03 Sypialnia ntpd[851]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 23 05:02:03 Sypialnia ntpd[851]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 23 05:02:03 Sypialnia ntpd[851]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1154 days ago Feb 23 05:02:03 Sypialnia ntpd[851]: Listen and drop on 0 v6wildcard [::]:123 Feb 23 05:02:03 Sypialnia ntpd[851]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 23 05:02:03 Sypialnia ntpd[851]: Listen normally on 2 lo 127.0.0.1:123 Feb 23 05:02:03 Sypialnia ntpd[851]: Listening on routing socket on fd #19 for interface updates Feb 23 05:02:03 Sypialnia ntpd[851]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 23 05:02:03 Sypialnia ntpd[851]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 23 05:02:03 Sypialnia sudo[848]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 0x48 0x48 Feb 23 05:02:03 Sypialnia sudo[856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 23 05:02:03 Sypialnia ifplugd(eth0)[875]: ifplugd 0.28 initializing. Feb 23 05:02:03 Sypialnia ifplugd(eth0)[875]: Using interface eth0/3C:7C:3F:CD:B1:D1 with driver (version: March_2013) Feb 23 05:02:03 Sypialnia ifplugd(eth0)[875]: Using detection mode: SIOCETHTOOL Feb 23 05:02:03 Sypialnia ifplugd(eth0)[875]: Initialization complete, link beat detected. Feb 23 05:02:03 Sypialnia sudo[856]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:03 Sypialnia sudo[848]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:03 Sypialnia sshd[867]: Server listening on 0.0.0.0 port 22. Feb 23 05:02:03 Sypialnia sshd[867]: Server listening on :: port 22. Feb 23 05:02:03 Sypialnia systemd[1]: Started OpenBSD Secure Shell server. Feb 23 05:02:03 Sypialnia sudo[856]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:03 Sypialnia sudo[848]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:03 Sypialnia systemd[1]: Started /etc/rc.local Compatibility. Feb 23 05:02:03 Sypialnia systemd[1]: Starting Terminate Plymouth Boot Screen... Feb 23 05:02:03 Sypialnia systemd[1]: Starting Hold until boot process finishes up... Feb 23 05:02:03 Sypialnia sudo[886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Feb 23 05:02:03 Sypialnia systemd[1]: Received SIGRTMIN+21 from PID 230 (plymouthd). Feb 23 05:02:03 Sypialnia sudo[886]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:03 Sypialnia ifplugd(eth0)[875]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Feb 23 05:02:03 Sypialnia systemd[1]: Received SIGRTMIN+21 from PID 230 (plymouthd). Feb 23 05:02:03 Sypialnia systemd[1]: plymouth-quit-wait.service: Succeeded. Feb 23 05:02:03 Sypialnia systemd[1]: Started Hold until boot process finishes up. Feb 23 05:02:03 Sypialnia systemd[1]: Started Serial Getty on ttyS3. Feb 23 05:02:03 Sypialnia systemd[1]: Reached target Login Prompts. Feb 23 05:02:03 Sypialnia systemd[1]: plymouth-quit.service: Succeeded. Feb 23 05:02:03 Sypialnia systemd[1]: Started Terminate Plymouth Boot Screen. Feb 23 05:02:03 Sypialnia ifplugd(eth0)[875]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Feb 23 05:02:03 Sypialnia sudo[886]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:03 Sypialnia sudo[912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 23 05:02:03 Sypialnia sudo[912]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:03 Sypialnia sudo[912]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:03 Sypialnia sudo[921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Feb 23 05:02:03 Sypialnia sudo[921]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:03 Sypialnia nmbd[840]: [2026/02/23 05:02:03.647259, 0] ../lib/param/loadparm.c:784(lpcfg_map_parameter) Feb 23 05:02:03 Sypialnia nmbd[840]: Unknown parameter encountered: "dns name" Feb 23 05:02:03 Sypialnia nmbd[840]: [2026/02/23 05:02:03.647386, 0] ../lib/param/loadparm.c:1810(lpcfg_do_global_parameter) Feb 23 05:02:03 Sypialnia nmbd[840]: Ignoring unknown parameter "dns name" Feb 23 05:02:03 Sypialnia nmbd[840]: [2026/02/23 05:02:03.648503, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Feb 23 05:02:03 Sypialnia nmbd[840]: started asyncdns process 929 Feb 23 05:02:03 Sypialnia nmbd[840]: [2026/02/23 05:02:03.649771, 0] ../lib/util/become_daemon.c:149(daemon_status) Feb 23 05:02:03 Sypialnia nmbd[840]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Feb 23 05:02:03 Sypialnia nmbd[840]: [2026/02/23 05:02:03.649864, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Feb 23 05:02:03 Sypialnia nmbd[840]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Feb 23 05:02:03 Sypialnia sh[500]: eth0: soliciting a DHCP lease Feb 23 05:02:03 Sypialnia dhcpcd[536]: eth0: soliciting a DHCP lease Feb 23 05:02:03 Sypialnia dhcpcd[673]: eth0: carrier lost Feb 23 05:02:03 Sypialnia sh[500]: eth0: carrier lost Feb 23 05:02:03 Sypialnia dhcpcd[536]: eth0: carrier lost Feb 23 05:02:04 Sypialnia ntpd[851]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Feb 23 05:02:05 Sypialnia ntpd[851]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Feb 23 05:02:06 Sypialnia ntpd[851]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Feb 23 05:02:06 Sypialnia volumio-time-update[549]: volumio-time-update-util: Fetching time from Volumio... Feb 23 05:02:06 Sypialnia volumio-time-update[549]: volumio-time-update-util: Date not found in response Feb 23 05:02:06 Sypialnia volumio-time-update[549]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 05:02:06 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:06] [info] asio async_connect error: system:111 (Connection refused) Feb 23 05:02:06 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:06] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 23 05:02:06 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:06] [error] handle_connect error: Underlying Transport Error Feb 23 05:02:06 Sypialnia systemd[1]: systemd-rfkill.service: Succeeded. Feb 23 05:02:07 Sypialnia ntpd[851]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Feb 23 05:02:08 Sypialnia sudo[921]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:08 Sypialnia wireless.js[564]: Start wireless flow Feb 23 05:02:08 Sypialnia wireless.js[564]: Stopped hotspot (if there).. Feb 23 05:02:08 Sypialnia sudo[964]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 23 05:02:08 Sypialnia sudo[964]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:08 Sypialnia sudo[964]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:08 Sypialnia sudo[973]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Feb 23 05:02:08 Sypialnia sudo[973]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:10 Sypialnia sudo[973]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:10 Sypialnia wireless.js[564]: DHCP IP Feb 23 05:02:10 Sypialnia wireless.js[564]: Start ap Feb 23 05:02:10 Sypialnia wpa_supplicant[982]: Successfully initialized wpa_supplicant Feb 23 05:02:10 Sypialnia sudo[983]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Feb 23 05:02:10 Sypialnia sudo[983]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:10 Sypialnia dhcpcd[988]: sending commands to master dhcpcd process Feb 23 05:02:10 Sypialnia dhcpcd[673]: control command: /sbin/dhcpcd Feb 23 05:02:10 Sypialnia sudo[983]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:11 Sypialnia wireless.js[564]: trying... Feb 23 05:02:11 Sypialnia sudo[994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:11 Sypialnia volumio-time-update[549]: volumio-time-update-util: Fetching time from Volumio... Feb 23 05:02:11 Sypialnia volumio-time-update[549]: volumio-time-update-util: Date not found in response Feb 23 05:02:11 Sypialnia volumio-time-update[549]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 05:02:11 Sypialnia sudo[994]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:11 Sypialnia sudo[994]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:12 Sypialnia wireless.js[564]: trying... Feb 23 05:02:12 Sypialnia sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:12 Sypialnia sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:12 Sypialnia sudo[1009]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:13 Sypialnia wireless.js[564]: trying... Feb 23 05:02:13 Sypialnia sudo[1019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:13 Sypialnia sudo[1019]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:13 Sypialnia sudo[1019]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:14 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:14] [info] asio async_connect error: system:111 (Connection refused) Feb 23 05:02:14 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:14] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 23 05:02:14 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:14] [error] handle_connect error: Underlying Transport Error Feb 23 05:02:14 Sypialnia wireless.js[564]: trying... Feb 23 05:02:14 Sypialnia sudo[1029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:14 Sypialnia sudo[1029]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:14 Sypialnia sudo[1029]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:15 Sypialnia wireless.js[564]: trying... Feb 23 05:02:15 Sypialnia sudo[1039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:15 Sypialnia sudo[1039]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:15 Sypialnia sudo[1039]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:16 Sypialnia wireless.js[564]: trying... Feb 23 05:02:16 Sypialnia wpa_supplicant[990]: wlan0: Trying to associate with f4:17:b8:61:8d:91 (SSID='mysia_norka_b5' freq=5180 MHz) Feb 23 05:02:16 Sypialnia volumio-time-update[549]: volumio-time-update-util: Fetching time from Volumio... Feb 23 05:02:16 Sypialnia volumio-time-update[549]: volumio-time-update-util: Date not found in response Feb 23 05:02:16 Sypialnia volumio-time-update[549]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 05:02:17 Sypialnia kernel: RTL871X: rtw_set_802_11_connect(wlan0) fw_state=0x00000008 Feb 23 05:02:17 Sypialnia sudo[1049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:17 Sypialnia sudo[1049]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:17 Sypialnia sudo[1049]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:17 Sypialnia wireless.js[564]: trying... Feb 23 05:02:17 Sypialnia sudo[1064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:17 Sypialnia sudo[1064]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:17 Sypialnia sudo[1064]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:17 Sypialnia kernel: RTL871X: start auth Feb 23 05:02:17 Sypialnia kernel: RTL871X: auth success, start assoc Feb 23 05:02:17 Sypialnia kernel: RTL871X: rtw_cfg80211_indicate_connect(wlan0) BSS not found !! Feb 23 05:02:17 Sypialnia kernel: RTL871X: assoc success Feb 23 05:02:18 Sypialnia wpa_supplicant[990]: wlan0: Associated with f4:17:b8:61:8d:91 Feb 23 05:02:18 Sypialnia wpa_supplicant[990]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Feb 23 05:02:18 Sypialnia kernel: RTL871X: send eapol packet Feb 23 05:02:18 Sypialnia wpa_supplicant[990]: wlan0: WPA: Key negotiation completed with f4:17:b8:61:8d:91 [PTK=CCMP GTK=CCMP] Feb 23 05:02:18 Sypialnia wpa_supplicant[990]: wlan0: CTRL-EVENT-CONNECTED - Connection to f4:17:b8:61:8d:91 completed [id=0 id_str=] Feb 23 05:02:18 Sypialnia dhcpcd[673]: wlan0: carrier acquired Feb 23 05:02:18 Sypialnia kernel: RTL871X: send eapol packet Feb 23 05:02:18 Sypialnia kernel: RTL871X: set pairwise key camid:4, addr:f4:17:b8:61:8d:91, kid:0, type:AES Feb 23 05:02:18 Sypialnia kernel: RTL871X: set group key camid:5, addr:f4:17:b8:61:8d:91, kid:1, type:AES Feb 23 05:02:18 Sypialnia dhcpcd[673]: wlan0: IAID ff:02:e0:d5 Feb 23 05:02:18 Sypialnia dhcpcd[673]: wlan0: adding address fe80::56c9:ffff:fe02:e0d5 Feb 23 05:02:18 Sypialnia dhcpcd[673]: ipv6_addaddr1: Permission denied Feb 23 05:02:18 Sypialnia wpa_supplicant[990]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=SE Feb 23 05:02:18 Sypialnia kernel: cfg80211: Regulatory domain changed to country: SE Feb 23 05:02:18 Sypialnia kernel: cfg80211: DFS Master region: ETSI Feb 23 05:02:18 Sypialnia kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Feb 23 05:02:18 Sypialnia kernel: cfg80211: (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Feb 23 05:02:18 Sypialnia kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Feb 23 05:02:18 Sypialnia kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Feb 23 05:02:18 Sypialnia kernel: cfg80211: (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2700 mBm), (0 s) Feb 23 05:02:18 Sypialnia kernel: cfg80211: (57000000 KHz - 66000000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A) Feb 23 05:02:18 Sypialnia dhcpcd[673]: wlan0: soliciting an IPv6 router Feb 23 05:02:18 Sypialnia wireless.js[564]: trying... Feb 23 05:02:18 Sypialnia dhcpcd[673]: wlan0: rebinding lease of 10.0.0.201 Feb 23 05:02:18 Sypialnia sudo[1077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:18 Sypialnia sudo[1077]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:18 Sypialnia sudo[1077]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:19 Sypialnia kernel: nf_conntrack: automatic helper assignment is deprecated and it will be removed soon. Use the iptables CT target to attach helpers instead. Feb 23 05:02:19 Sypialnia wireless.js[564]: trying... Feb 23 05:02:19 Sypialnia sudo[1087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:19 Sypialnia sudo[1087]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:19 Sypialnia sudo[1087]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:20 Sypialnia wireless.js[564]: trying... Feb 23 05:02:20 Sypialnia sudo[1097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:20 Sypialnia sudo[1097]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:20 Sypialnia sudo[1097]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:21 Sypialnia wireless.js[564]: trying... Feb 23 05:02:21 Sypialnia volumio-time-update[549]: volumio-time-update-util: Fetching time from Volumio... Feb 23 05:02:21 Sypialnia volumio-time-update[549]: volumio-time-update-util: Date not found in response Feb 23 05:02:21 Sypialnia volumio-time-update[549]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 05:02:21 Sypialnia sudo[1107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:21 Sypialnia sudo[1107]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:21 Sypialnia sudo[1107]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:22 Sypialnia wireless.js[564]: trying... Feb 23 05:02:22 Sypialnia sudo[1122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:22 Sypialnia sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:22 Sypialnia sudo[1122]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:23 Sypialnia wireless.js[564]: trying... Feb 23 05:02:23 Sypialnia dhcpcd[673]: wlan0: probing for an IPv4LL address Feb 23 05:02:23 Sypialnia dhcpcd[673]: wlan0: DHCP lease expired Feb 23 05:02:23 Sypialnia dhcpcd[673]: wlan0: soliciting a DHCP lease Feb 23 05:02:23 Sypialnia sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:23 Sypialnia sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:23 Sypialnia sudo[1132]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:24 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:24] [info] asio async_connect error: system:111 (Connection refused) Feb 23 05:02:24 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:24] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 23 05:02:24 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:24] [error] handle_connect error: Underlying Transport Error Feb 23 05:02:24 Sypialnia wireless.js[564]: trying... Feb 23 05:02:24 Sypialnia sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:24 Sypialnia sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:24 Sypialnia sudo[1148]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:25 Sypialnia wireless.js[564]: trying... Feb 23 05:02:25 Sypialnia sudo[1158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:25 Sypialnia sudo[1158]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:25 Sypialnia sudo[1158]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:26 Sypialnia wireless.js[564]: trying... Feb 23 05:02:26 Sypialnia volumio-time-update[549]: volumio-time-update-util: Fetching time from Volumio... Feb 23 05:02:26 Sypialnia sudo[1168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:26 Sypialnia sudo[1168]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:26 Sypialnia volumio-time-update[549]: volumio-time-update-util: Date not found in response Feb 23 05:02:26 Sypialnia volumio-time-update[549]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 05:02:26 Sypialnia sudo[1168]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:27 Sypialnia wireless.js[564]: trying... Feb 23 05:02:27 Sypialnia sudo[1183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:27 Sypialnia sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:27 Sypialnia sudo[1183]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:28 Sypialnia wireless.js[564]: trying... Feb 23 05:02:28 Sypialnia sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:28 Sypialnia sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:28 Sypialnia sudo[1193]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:29 Sypialnia dhcpcd[673]: wlan0: using IPv4LL address 169.254.117.224 Feb 23 05:02:29 Sypialnia avahi-daemon[561]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.117.224. Feb 23 05:02:29 Sypialnia avahi-daemon[561]: New relevant interface wlan0.IPv4 for mDNS. Feb 23 05:02:29 Sypialnia dhcpcd[673]: wlan0: adding route to 169.254.0.0/16 Feb 23 05:02:29 Sypialnia dhcpcd[673]: wlan0: adding default route Feb 23 05:02:29 Sypialnia avahi-daemon[561]: Registering new address record for 169.254.117.224 on wlan0.IPv4. Feb 23 05:02:29 Sypialnia wireless.js[564]: trying... Feb 23 05:02:29 Sypialnia sudo[1211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 05:02:29 Sypialnia sudo[1211]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:29 Sypialnia sudo[1211]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:30 Sypialnia wireless.js[564]: Connected to: ----mysia_norka_b5 Feb 23 05:02:30 Sypialnia wireless.js[564]: ---- Feb 23 05:02:30 Sypialnia sudo[1221]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 05:02:30 Sypialnia sudo[1221]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:30 Sypialnia sudo[1221]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:30 Sypialnia wireless.js[564]: ... joined AP, wlan0 IPv4 is 169.254.117.224, ipV6 is undefined Feb 23 05:02:30 Sypialnia wireless.js[564]: It's done! AP Feb 23 05:02:30 Sypialnia iwconfig[1232]: Error for wireless request "Set Power Management" (8B2C) : Feb 23 05:02:30 Sypialnia iwconfig[1232]: SET failed on device wlan0 ; Operation not permitted. Feb 23 05:02:30 Sypialnia systemd[1]: Started Wireless Services. Feb 23 05:02:30 Sypialnia systemd[1]: Started Volumio Backend Module. Feb 23 05:02:30 Sypialnia systemd[1]: Started Volumio Cpu Tweaker. Feb 23 05:02:30 Sypialnia volumio-cpu-tweak[1234]: Setting RT Priority for mpd Feb 23 05:02:30 Sypialnia volumio-cpu-tweak[1234]: pid 35's current scheduling policy: SCHED_OTHER Feb 23 05:02:30 Sypialnia volumio-cpu-tweak[1234]: pid 35's current scheduling priority: 0 Feb 23 05:02:30 Sypialnia systemd[1]: systemd-fsckd.service: Succeeded. Feb 23 05:02:30 Sypialnia volumio-cpu-tweak[1234]: Setting MPD Affinity Feb 23 05:02:30 Sypialnia volumio-cpu-tweak[1234]: pid 3's current affinity mask: 1 Feb 23 05:02:30 Sypialnia volumio-cpu-tweak[1234]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Feb 23 05:02:30 Sypialnia volumio-cpu-tweak[1234]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Feb 23 05:02:30 Sypialnia systemd[1]: volumio_cpu_tweak.service: Succeeded. Feb 23 05:02:31 Sypialnia ntpd[851]: Listen normally on 3 wlan0 169.254.117.224:123 Feb 23 05:02:31 Sypialnia ntpd[851]: new interface(s) found: waking up resolver Feb 23 05:02:31 Sypialnia sh[500]: timed out Feb 23 05:02:31 Sypialnia dhcpcd[536]: timed out Feb 23 05:02:31 Sypialnia sh[500]: dhcpcd exited Feb 23 05:02:31 Sypialnia dhcpcd[536]: dhcpcd exited Feb 23 05:02:31 Sypialnia sh[500]: ifup: failed to bring up eth0 Feb 23 05:02:31 Sypialnia systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Feb 23 05:02:31 Sypialnia systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Feb 23 05:02:31 Sypialnia ifplugd(eth0)[875]: client: sending commands to master dhcpcd process Feb 23 05:02:31 Sypialnia dhcpcd[1264]: sending commands to master dhcpcd process Feb 23 05:02:31 Sypialnia dhcpcd[673]: control command: /sbin/dhcpcd eth0 Feb 23 05:02:31 Sypialnia volumio-time-update[549]: volumio-time-update-util: Fetching time from Volumio... Feb 23 05:02:31 Sypialnia ifplugd(eth0)[875]: Program executed successfully. Feb 23 05:02:31 Sypialnia ifplugd(eth0)[875]: Link beat lost. Feb 23 05:02:31 Sypialnia ifplugd[823]: Network Interface Plugging Daemon...start eth0...done. Feb 23 05:02:31 Sypialnia systemd[1]: Started LSB: Brings up/down network automatically. Feb 23 05:02:32 Sypialnia volumio[1233]: info: ------------------------------------------- Feb 23 05:02:32 Sypialnia volumio[1233]: info: ----- Volumio3 ---- Feb 23 05:02:32 Sypialnia volumio[1233]: info: ------------------------------------------- Feb 23 05:02:32 Sypialnia volumio[1233]: info: ----- System startup ---- Feb 23 05:02:32 Sypialnia volumio[1233]: info: ------------------------------------------- Feb 23 05:02:32 Sypialnia volumio[1233]: info: MYVOLUMIO Environment detected Feb 23 05:02:33 Sypialnia volumio[1233]: info: Plugin folders cleanup Feb 23 05:02:33 Sypialnia volumio[1233]: info: Scanning into folder /volumio/app/plugins/ Feb 23 05:02:33 Sypialnia volumio[1233]: info: Scanning category audio_interface Feb 23 05:02:33 Sypialnia volumio[1233]: info: Scanning category miscellanea Feb 23 05:02:33 Sypialnia volumio[1233]: info: Scanning category music_service Feb 23 05:02:33 Sypialnia volumio[1233]: info: Scanning category plugins.json Feb 23 05:02:33 Sypialnia volumio[1233]: info: Scanning category system_controller Feb 23 05:02:33 Sypialnia volumio[1233]: info: Scanning category user_interface Feb 23 05:02:33 Sypialnia volumio[1233]: info: Scanning into folder /data/plugins/ Feb 23 05:02:33 Sypialnia volumio[1233]: info: Scanning category music_service Feb 23 05:02:33 Sypialnia volumio[1233]: info: Scanning category system_controller Feb 23 05:02:33 Sypialnia volumio[1233]: info: Scanning category system_hardware Feb 23 05:02:33 Sypialnia volumio[1233]: info: Scanning category user_interface Feb 23 05:02:33 Sypialnia volumio[1233]: info: Plugin folders cleanup completed Feb 23 05:02:33 Sypialnia volumio[1233]: info: ------------------------------------------- Feb 23 05:02:33 Sypialnia volumio[1233]: info: ----- Core plugins startup ---- Feb 23 05:02:33 Sypialnia volumio[1233]: info: ------------------------------------------- Feb 23 05:02:33 Sypialnia volumio[1233]: info: Loading plugins from folder /volumio/app/plugins/ Feb 23 05:02:33 Sypialnia volumio[1233]: info: Adding plugin upnp to MyMusic Plugins Feb 23 05:02:33 Sypialnia volumio[1233]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 23 05:02:33 Sypialnia volumio[1233]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 23 05:02:33 Sypialnia volumio[1233]: info: Loading plugins from folder /data/plugins/ Feb 23 05:02:33 Sypialnia volumio[1233]: info: Loading plugin "system"... Feb 23 05:02:33 Sypialnia volumio[1233]: info: Loading plugin "appearance"... Feb 23 05:02:33 Sypialnia nmbd[840]: [2026/02/23 05:02:33.661489, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 23 05:02:33 Sypialnia systemd[1]: Started Samba NMB Daemon. Feb 23 05:02:33 Sypialnia nmbd[840]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Feb 23 05:02:33 Sypialnia systemd[1]: Starting Samba Winbind Daemon... Feb 23 05:02:33 Sypialnia winbindd[1306]: [2026/02/23 05:02:33.869517, 0] ../lib/param/loadparm.c:784(lpcfg_map_parameter) Feb 23 05:02:33 Sypialnia winbindd[1306]: Unknown parameter encountered: "dns name" Feb 23 05:02:33 Sypialnia winbindd[1306]: [2026/02/23 05:02:33.869708, 0] ../lib/param/loadparm.c:1810(lpcfg_do_global_parameter) Feb 23 05:02:33 Sypialnia winbindd[1306]: Ignoring unknown parameter "dns name" Feb 23 05:02:33 Sypialnia winbindd[1306]: [2026/02/23 05:02:33.878125, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Feb 23 05:02:33 Sypialnia winbindd[1306]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 23 05:02:33 Sypialnia winbindd[1306]: [2026/02/23 05:02:33.886369, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 23 05:02:33 Sypialnia systemd[1]: Started Samba Winbind Daemon. Feb 23 05:02:33 Sypialnia winbindd[1306]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Feb 23 05:02:33 Sypialnia systemd[1]: Starting Samba SMB Daemon... Feb 23 05:02:33 Sypialnia volumio[1233]: info: Loading plugin "network"... Feb 23 05:02:33 Sypialnia volumio[1233]: info: Refreshing Cached IP Addresses Feb 23 05:02:34 Sypialnia sudo[1313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 05:02:34 Sypialnia sudo[1313]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "services"... Feb 23 05:02:34 Sypialnia sudo[1315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "volumio5onboarding"... Feb 23 05:02:34 Sypialnia sudo[1313]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:34 Sypialnia sudo[1325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "alsa_controller"... Feb 23 05:02:34 Sypialnia sudo[1315]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:34 Sypialnia sudo[1325]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:34 Sypialnia sudo[1315]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:34 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:34] [connect] Successful connection Feb 23 05:02:34 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "wizard"... Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "networkfs"... Feb 23 05:02:34 Sypialnia smbd[1311]: [2026/02/23 05:02:34.175756, 0] ../lib/param/loadparm.c:784(lpcfg_map_parameter) Feb 23 05:02:34 Sypialnia smbd[1311]: Unknown parameter encountered: "dns name" Feb 23 05:02:34 Sypialnia smbd[1311]: [2026/02/23 05:02:34.175961, 0] ../lib/param/loadparm.c:1810(lpcfg_do_global_parameter) Feb 23 05:02:34 Sypialnia smbd[1311]: Ignoring unknown parameter "dns name" Feb 23 05:02:34 Sypialnia volumio[1233]: info: Starting Udev Watcher for removable devices Feb 23 05:02:34 Sypialnia sudo[1366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.0.0.2/music /mnt/NAS/music Feb 23 05:02:34 Sypialnia volumio[1233]: info: Ignoring mount for partition: boot Feb 23 05:02:34 Sypialnia volumio[1233]: info: Ignoring mount for partition: volumio Feb 23 05:02:34 Sypialnia volumio[1233]: info: Ignoring mount for partition: volumio_data Feb 23 05:02:34 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "volumio_command_line_client"... Feb 23 05:02:34 Sypialnia sudo[1366]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:34 Sypialnia sudo[1370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //127.0.0.1/Internal Storage /mnt/NAS/Internal_Storage Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "upnp"... Feb 23 05:02:34 Sypialnia volumio[1233]: info: [1771819354256] Starting Upmpd Daemon Feb 23 05:02:34 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "my_music"... Feb 23 05:02:34 Sypialnia sudo[1370]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "mpd"... Feb 23 05:02:34 Sypialnia smbd[1311]: [2026/02/23 05:02:34.275619, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 23 05:02:34 Sypialnia systemd[1]: Started Samba SMB Daemon. Feb 23 05:02:34 Sypialnia smbd[1311]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 23 05:02:34 Sypialnia smbd[1389]: [2026/02/23 05:02:34.324464, 0] ../lib/param/loadparm.c:784(lpcfg_map_parameter) Feb 23 05:02:34 Sypialnia smbd[1389]: Unknown parameter encountered: "dns name" Feb 23 05:02:34 Sypialnia smbd[1389]: [2026/02/23 05:02:34.324602, 0] ../lib/param/loadparm.c:1810(lpcfg_do_global_parameter) Feb 23 05:02:34 Sypialnia smbd[1389]: Ignoring unknown parameter "dns name" Feb 23 05:02:34 Sypialnia sudo[1370]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:34 Sypialnia volumio[1233]: info: Plugin upnp_browser is not enabled Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "alarm-clock"... Feb 23 05:02:34 Sypialnia volumio[1233]: info: Plugin airplay_emulation is not enabled Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "last_100"... Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "webradio"... Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "i2s_dacs"... Feb 23 05:02:34 Sypialnia volumio[1233]: info: I2S DAC not set, start Auto-detection Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "volumiodiscovery"... Feb 23 05:02:34 Sypialnia volumio[1233]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 23 05:02:34 Sypialnia node[1233]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 23 05:02:34 Sypialnia volumio[1233]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 05:02:34 Sypialnia node[1233]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 05:02:34 Sypialnia volumio[1233]: *** WARNING *** For more information see Feb 23 05:02:34 Sypialnia node[1233]: *** WARNING *** For more information see Feb 23 05:02:34 Sypialnia volumio[1233]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 23 05:02:34 Sypialnia node[1233]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 23 05:02:34 Sypialnia volumio[1233]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 05:02:34 Sypialnia node[1233]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 05:02:34 Sypialnia volumio[1233]: *** WARNING *** For more information see Feb 23 05:02:34 Sypialnia node[1233]: *** WARNING *** For more information see Feb 23 05:02:34 Sypialnia volumio[1233]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 23 05:02:34 Sypialnia volumio[1233]: info: Discovery: Started advertising with name: Sypialnia Feb 23 05:02:34 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 05:02:34 Sypialnia volumio[1233]: info: Loading plugin "spop"... Feb 23 05:02:35 Sypialnia volumio[1233]: info: Plugin SleepWakePlugin is not enabled Feb 23 05:02:35 Sypialnia volumio[1233]: info: Loading plugin "outputs"... Feb 23 05:02:35 Sypialnia volumio[1233]: info: Loading plugin "albumart"... Feb 23 05:02:35 Sypialnia volumio[1233]: info: Plugin example_plugin is not enabled Feb 23 05:02:35 Sypialnia volumio[1233]: info: Loading plugin "inputs"... Feb 23 05:02:35 Sypialnia volumio[1233]: info: Loading plugin "updater_comm"... Feb 23 05:02:35 Sypialnia volumio[1233]: info: Plugin mpdemulation is not enabled Feb 23 05:02:35 Sypialnia volumio[1233]: info: Loading plugin "rest_api"... Feb 23 05:02:35 Sypialnia volumio[1233]: info: Loading plugin "websocket"... Feb 23 05:02:35 Sypialnia volumio[1233]: info: Starting Socket.io Server version 2.3.0 Feb 23 05:02:35 Sypialnia volumio[1233]: info: Loading plugin "radio_paradise"... Feb 23 05:02:35 Sypialnia volumio[1233]: Forking 3 albumart workers Feb 23 05:02:36 Sypialnia volumio[1233]: info: Applying required configuration parameters for plugin radio_paradise Feb 23 05:02:36 Sypialnia volumio[1233]: info: [1771819356057] [RadioParadise] API delay: 5 Feb 23 05:02:36 Sypialnia volumio[1233]: info: Loading plugin "scheduledrestart"... Feb 23 05:02:36 Sypialnia volumio[1233]: info: Applying required configuration parameters for plugin scheduledrestart Feb 23 05:02:36 Sypialnia volumio[1233]: info: Loading plugin "music_services_shield"... Feb 23 05:02:36 Sypialnia volumio[1233]: Starting albumart workers Feb 23 05:02:36 Sypialnia volumio[1233]: Starting albumart workers Feb 23 05:02:36 Sypialnia volumio[1233]: info: Applying required configuration parameters for plugin music_services_shield Feb 23 05:02:36 Sypialnia volumio[1233]: info: Plugin lastfm is not enabled Feb 23 05:02:36 Sypialnia volumio[1233]: info: Loading i18n strings for locale pl Feb 23 05:02:36 Sypialnia volumio[1233]: Updating browse sources language Feb 23 05:02:36 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 05:02:36 Sypialnia volumio[1233]: Starting albumart workers Feb 23 05:02:36 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 05:02:36 Sypialnia volumio[1233]: info: CoreCommandRouter::initPlayerControls Feb 23 05:02:36 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:36 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:36 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:36 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:36 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:36 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:36 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:36 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:36 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 05:02:36 Sypialnia volumio[1233]: Express server listening on port 3000 Feb 23 05:02:36 Sypialnia volumio[1233]: [Metrics] WebUI: 5s 232.30ms Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreStateMachine::resetVolumioState Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreStateMachine::getcurrentVolume Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 23 05:02:37 Sypialnia volumio[1233]: info: Completed loading Core Plugins Feb 23 05:02:37 Sypialnia volumio[1233]: info: Preparing to generate the ALSA configuration file Feb 23 05:02:37 Sypialnia volumio[1233]: info: Volumio Network Manager: Network status updated: 2 Feb 23 05:02:37 Sypialnia volumio[1233]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 23 05:02:37 Sypialnia volumio[1233]: info: Reading ALSA contributions from plugins. Feb 23 05:02:37 Sypialnia volumio-remote-updater[558]: [2026-02-23 05:02:37] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1771819354 101 Feb 23 05:02:37 Sypialnia volumio[1233]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Feb 23 05:02:37 Sypialnia volumio[1233]: info: Reloading queue from file Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreStateMachine::setRepeat true single undefined Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreStateMachine::pushState Feb 23 05:02:37 Sypialnia volumio[1233]: info: CorePlayQueue::getTrack 0 Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioPushState Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreStateMachine::setRandom false Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreStateMachine::pushState Feb 23 05:02:37 Sypialnia volumio[1233]: info: CorePlayQueue::getTrack 0 Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioPushState Feb 23 05:02:37 Sypialnia volumio[1233]: info: VolumeController:: Volume=17 Mute =false Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreStateMachine::pushState Feb 23 05:02:37 Sypialnia volumio[1233]: info: CorePlayQueue::getTrack 0 Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioPushState Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreStateMachine::updateTrackBlock Feb 23 05:02:37 Sypialnia volumio[1233]: info: CorePlayQueue::getTrackBlock Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 05:02:37 Sypialnia volumio[1233]: info: Setting Device type: Tinkerboard Feb 23 05:02:37 Sypialnia volumio[1233]: info: Asound.conf file unchanged, so no further update is needed Feb 23 05:02:37 Sypialnia volumio[1233]: info: Output device has changed, restarting MPD Feb 23 05:02:37 Sypialnia volumio[1233]: info: ___________ START PLUGINS ___________ Feb 23 05:02:37 Sypialnia sudo[1456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 05:02:37 Sypialnia volumio[1233]: info: ControllerMpd::onStart: Initializing MPD Feb 23 05:02:37 Sypialnia volumio[1233]: info: Creating MPD Configuration file Feb 23 05:02:37 Sypialnia sudo[1460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 05:02:37 Sypialnia sudo[1456]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:37 Sypialnia sudo[1462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 05:02:37 Sypialnia volumio[1233]: info: [1771819357326] CoreMusicLibrary::Adding element Last_100 Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 05:02:37 Sypialnia volumio[1233]: info: [1771819357331] CoreMusicLibrary::Adding element Webradio Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 05:02:37 Sypialnia sudo[1460]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 05:02:37 Sypialnia sudo[1456]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:37 Sypialnia sudo[1471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 05:02:37 Sypialnia volumio[1233]: info: Initializing BBC Radios Feb 23 05:02:37 Sypialnia sudo[1474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 05:02:37 Sypialnia sudo[1462]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:37 Sypialnia systemd[1]: musicservicesshield.service: Succeeded. Feb 23 05:02:37 Sypialnia systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Feb 23 05:02:37 Sypialnia systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Feb 23 05:02:37 Sypialnia systemd[1]: Listening on mpd.socket. Feb 23 05:02:37 Sypialnia systemd[1]: Starting Music Player Daemon... Feb 23 05:02:37 Sypialnia sudo[1471]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:37 Sypialnia sudo[1474]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:37 Sypialnia sudo[1471]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:37 Sypialnia systemd[1]: Started Volumio5 Onboarding Server. Feb 23 05:02:37 Sypialnia sudo[1462]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: Creating Spotify config file Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 05:02:37 Sypialnia volumio[1233]: info: [1771819357463] CoreMusicLibrary::Adding element Radio Paradise Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 05:02:37 Sypialnia volumio[1233]: Cannot find translation for source Radio Paradise Feb 23 05:02:37 Sypialnia volumio[1233]: info: Scheduling reboots with hours: 5, minutes: 0 in timezone: Europe/Warsaw Feb 23 05:02:37 Sypialnia volumio[1233]: info: Scheduling job with cron expression: 0 0 5 * * 0 Feb 23 05:02:37 Sypialnia systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 23 05:02:37 Sypialnia systemd[1]: mpd.service: Succeeded. Feb 23 05:02:37 Sypialnia systemd[1]: Stopped Music Player Daemon. Feb 23 05:02:37 Sypialnia systemd[1]: Starting Music Player Daemon... Feb 23 05:02:37 Sypialnia volumio[1233]: info: Scheduling job with cron expression: 0 0 5 * * 1 Feb 23 05:02:37 Sypialnia volumio[1233]: info: Scheduling job with cron expression: 0 0 5 * * 2 Feb 23 05:02:37 Sypialnia volumio[1233]: info: Scheduling job with cron expression: 0 0 5 * * 3 Feb 23 05:02:37 Sypialnia volumio[1233]: info: Scheduling job with cron expression: 0 0 5 * * 4 Feb 23 05:02:37 Sypialnia volumio[1233]: info: Scheduling job with cron expression: 0 0 5 * * 5 Feb 23 05:02:37 Sypialnia volumio[1233]: info: Scheduling job with cron expression: 0 0 5 * * 6 Feb 23 05:02:37 Sypialnia sudo[1520]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 05:02:37 Sypialnia sudo[1520]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:37 Sypialnia sudo[1520]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 23 05:02:37 Sypialnia sudo[1520]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:37 Sypialnia volumio[1233]: info: Volumio Calling Home Feb 23 05:02:37 Sypialnia volumio5-onboarding[1510]: time=2026-02-23T05:02:37.703+01:00 level=INFO msg="running volumio5-device-gateway" version=9838fecf+CHANGES buildDate=2026-01-16T16:06:14Z Feb 23 05:02:37 Sypialnia sudo[1563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Feb 23 05:02:37 Sypialnia sudo[1563]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:37 Sypialnia volumio[1233]: info: MPD Permissions set Feb 23 05:02:37 Sypialnia volumio[1233]: info: MPD Permissions set Feb 23 05:02:37 Sypialnia volumio[1233]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Feb 23 05:02:37 Sypialnia volumio[1233]: info: Spotify config file written Feb 23 05:02:37 Sypialnia volumio[1233]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Feb 23 05:02:37 Sypialnia volumio5-onboarding[1510]: time=2026-02-23T05:02:37.920+01:00 level=INFO msg="listening for BLE messages" address=70:66:55:E6:63:48%00 Feb 23 05:02:37 Sypialnia volumio5-onboarding[1510]: time=2026-02-23T05:02:37.921+01:00 level=INFO msg="listening for WebSocket messages" address=[::]:7331 Feb 23 05:02:37 Sypialnia volumio[1233]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia sudo[1583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 23 05:02:37 Sypialnia sudo[1583]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:37 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:38 Sypialnia go-librespot[1597]: go-librespot daemon starting... Feb 23 05:02:38 Sypialnia systemd[1]: Started go-librespot Daemon. Feb 23 05:02:38 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 05:02:38 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 23 05:02:38 Sypialnia sudo[1583]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:38 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 05:02:38 Sypialnia volumio[1233]: info: No need to fix Spotify hosts Feb 23 05:02:38 Sypialnia volumio[1233]: info: Received Get System Info Feb 23 05:02:38 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 05:02:38 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 05:02:38 Sypialnia volumio[1233]: info: Discovery: Getting this device information Feb 23 05:02:38 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioGetState Feb 23 05:02:38 Sypialnia volumio[1233]: info: CorePlayQueue::getTrack 0 Feb 23 05:02:38 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 05:02:38 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 23 05:02:38 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 23 05:02:38 Sypialnia volumio5-onboarding[1510]: time=2026-02-23T05:02:38.103+01:00 level=INFO msg="BLE descriptor updated" deviceId=6bc61afcb5a7bbea87624c9286324aa2 deviceName=Sypialnia deviceModel= Feb 23 05:02:38 Sypialnia volumio5-onboarding[1510]: time=2026-02-23T05:02:38.104+01:00 level=INFO msg="mDNS descriptor updated" deviceId=6bc61afcb5a7bbea87624c9286324aa2 deviceName=Sypialnia deviceModel= Feb 23 05:02:38 Sypialnia volumio[1233]: info: VolumeController:: Volume=17 Mute =false Feb 23 05:02:38 Sypialnia volumio[1233]: info: CoreStateMachine::pushState Feb 23 05:02:38 Sypialnia volumio[1233]: info: CorePlayQueue::getTrack 0 Feb 23 05:02:38 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioPushState Feb 23 05:02:38 Sypialnia go-librespot[1597]: time="2026-02-23T05:02:38+01:00" level=info msg="running go-librespot 0.4.0" Feb 23 05:02:38 Sypialnia go-librespot[1597]: time="2026-02-23T05:02:38+01:00" level=debug msg="app state loaded" Feb 23 05:02:38 Sypialnia go-librespot[1597]: time="2026-02-23T05:02:38+01:00" level=debug msg="stored credentials not found" Feb 23 05:02:38 Sypialnia go-librespot[1597]: time="2026-02-23T05:02:38+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 23 05:02:38 Sypialnia sudo[1563]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:38 Sypialnia sudo[1628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh Feb 23 05:02:38 Sypialnia sudo[1628]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:38 Sypialnia sudo[1325]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:39 Sypialnia mpd[1559]: Feb 23 05:02 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 23 05:02:39 Sypialnia systemd[1]: Started Music Player Daemon. Feb 23 05:02:39 Sypialnia sudo[1474]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:39 Sypialnia sudo[1460]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:39 Sypialnia systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Feb 23 05:02:39 Sypialnia volumio[1233]: info: Completed starting Core Plugins Feb 23 05:02:39 Sypialnia volumio[1233]: info: ------------------------------------------- Feb 23 05:02:39 Sypialnia volumio[1233]: info: ----- MyVolumio plugins startup ---- Feb 23 05:02:39 Sypialnia volumio[1233]: info: ------------------------------------------- Feb 23 05:02:39 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 23 05:02:39 Sypialnia volumio[1233]: error: MPD error: The expression evaluated to a falsy value: Feb 23 05:02:39 Sypialnia volumio[1233]: assert.ok(self.idling) Feb 23 05:02:39 Sypialnia volumio[1233]: error: The expression evaluated to a falsy value: Feb 23 05:02:39 Sypialnia volumio[1233]: assert.ok(self.idling) Feb 23 05:02:39 Sypialnia volumio[1233]: info: MPD running with PID1559 Feb 23 05:02:39 Sypialnia volumio[1233]: ,establishing connection Feb 23 05:02:39 Sypialnia volumio[1233]: error: MPD error: The expression evaluated to a falsy value: Feb 23 05:02:39 Sypialnia volumio[1233]: assert.ok(self.idling) Feb 23 05:02:39 Sypialnia volumio[1233]: error: The expression evaluated to a falsy value: Feb 23 05:02:39 Sypialnia volumio[1233]: assert.ok(self.idling) Feb 23 05:02:39 Sypialnia volumio[1233]: error: updateQueue error: null Feb 23 05:02:39 Sypialnia volumio[1647]: cset: --> shielding system active with Feb 23 05:02:39 Sypialnia volumio[1647]: cset: "system" cpuset of CPUSPEC(1-3) with 131 tasks running Feb 23 05:02:39 Sypialnia volumio[1647]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Feb 23 05:02:39 Sypialnia systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Feb 23 05:02:39 Sypialnia systemd[1]: Reloading. Feb 23 05:02:39 Sypialnia systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Feb 23 05:02:39 Sypialnia systemd[1]: serial-getty@ttyS3.service: Current command vanished from the unit file, execution of the command list won't be resumed. Feb 23 05:02:40 Sypialnia sudo[1628]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:40 Sypialnia volumio[1233]: info: succeeded Feb 23 05:02:41 Sypialnia volumio[1233]: info: go-librespot daemon successfully initialized Feb 23 05:02:42 Sypialnia ifplugd(eth0)[875]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Feb 23 05:02:42 Sypialnia ifplugd(eth0)[875]: client: sending commands to master dhcpcd process Feb 23 05:02:42 Sypialnia dhcpcd[1698]: sending commands to master dhcpcd process Feb 23 05:02:42 Sypialnia dhcpcd[673]: control command: /sbin/dhcpcd -k eth0 Feb 23 05:02:42 Sypialnia dhcpcd[673]: eth0: removing interface Feb 23 05:02:42 Sypialnia ifplugd(eth0)[875]: Program executed successfully. Feb 23 05:02:42 Sypialnia volumio[1233]: info: Received Get System Info Feb 23 05:02:42 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 05:02:42 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 05:02:42 Sypialnia volumio[1233]: info: Discovery: Getting this device information Feb 23 05:02:42 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioGetState Feb 23 05:02:42 Sypialnia volumio[1233]: info: CorePlayQueue::getTrack 0 Feb 23 05:02:42 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 05:02:42 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 23 05:02:42 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 23 05:02:42 Sypialnia volumio5-onboarding[1510]: time=2026-02-23T05:02:42.787+01:00 level=INFO msg="BLE descriptor updated" deviceId=6bc61afcb5a7bbea87624c9286324aa2 deviceName=Sypialnia deviceModel= Feb 23 05:02:42 Sypialnia volumio5-onboarding[1510]: time=2026-02-23T05:02:42.787+01:00 level=INFO msg="mDNS descriptor updated" deviceId=6bc61afcb5a7bbea87624c9286324aa2 deviceName=Sypialnia deviceModel= Feb 23 05:02:43 Sypialnia volumio5-onboarding[1510]: time=2026-02-23T05:02:43.105+01:00 level=INFO msg="bootstrapping state" hasInternet=false Feb 23 05:02:44 Sypialnia volumio[1233]: info: Initializing connection to go-librespot Websocket Feb 23 05:02:44 Sypialnia sudo[1732]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 05:02:44 Sypialnia sudo[1734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 05:02:44 Sypialnia sudo[1732]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:44 Sypialnia sudo[1734]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:44 Sypialnia sudo[1739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 23 05:02:44 Sypialnia sudo[1732]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:44 Sypialnia sudo[1734]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:44 Sypialnia sudo[1739]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:02:44 Sypialnia systemd[1]: Started UPnP Renderer front-end to MPD. Feb 23 05:02:44 Sypialnia sudo[1739]: pam_unix(sudo:session): session closed for user root Feb 23 05:02:44 Sypialnia volumio[1233]: info: Upmpdcli Daemon Started Feb 23 05:02:44 Sypialnia volumio[1233]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 23 05:02:44 Sypialnia volumio[1758]: Generating RSA private key, 4096 bit long modulus (2 primes) Feb 23 05:02:51 Sypialnia volumio-time-update[549]: volumio-time-update-util: Date not found in response Feb 23 05:02:51 Sypialnia volumio-time-update[549]: volumio-time-update-util: Retrying in 5 seconds... Feb 23 05:02:52 Sypialnia volumio[1758]: ..................................................................................................................................................................++++ Feb 23 05:02:53 Sypialnia dhcpcd[673]: wlan0: offered 10.0.0.201 from 10.0.0.2 Feb 23 05:02:53 Sypialnia dhcpcd[673]: wlan0: probing address 10.0.0.201/24 Feb 23 05:02:56 Sypialnia volumio-time-update[549]: volumio-time-update-util: Fetching time from Volumio... Feb 23 05:02:57 Sypialnia volumio[1758]: ..........................................................................................................++++ Feb 23 05:02:57 Sypialnia volumio[1758]: e is 65537 (0x010001) Feb 23 05:02:57 Sypialnia volumio[1758]: writing RSA key Feb 23 05:02:57 Sypialnia dhcpcd[673]: wlan0: leased 10.0.0.201 for 86400 seconds Feb 23 05:02:57 Sypialnia dhcpcd[673]: wlan0: adding route to 10.0.0.0/24 Feb 23 05:02:57 Sypialnia dhcpcd[673]: wlan0: changing default route via 10.0.0.2 Feb 23 05:02:57 Sypialnia avahi-daemon[561]: Registering new address record for 10.0.0.201 on wlan0.IPv4. Feb 23 05:02:57 Sypialnia volumio[1233]: verbose: New Socket.io Connection to 10.0.0.201:3000 from 10.0.0.200 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 23 05:02:57 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Feb 23 05:02:57 Sypialnia ntpd[851]: ntpd exiting on signal 15 (Terminated) Feb 23 05:02:57 Sypialnia systemd[1]: Stopping Network Time Service... Feb 23 05:02:57 Sypialnia systemd[1]: ntp.service: Succeeded. Feb 23 05:02:57 Sypialnia systemd[1]: Stopped Network Time Service. Feb 23 05:02:57 Sypialnia systemd[1]: Starting Network Time Service... Feb 23 05:02:57 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioGetState Feb 23 05:02:57 Sypialnia volumio[1233]: info: CorePlayQueue::getTrack 0 Feb 23 05:02:57 Sypialnia ntpd[1847]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 23 05:02:57 Sypialnia ntpd[1847]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 104:103 Feb 23 05:02:57 Sypialnia systemd[1]: Started Network Time Service. Feb 23 05:02:57 Sypialnia ntpd[1853]: proto: precision = 0.583 usec (-21) Feb 23 05:02:57 Sypialnia ntpd[1853]: Listen and drop on 0 v6wildcard [::]:123 Feb 23 05:02:57 Sypialnia ntpd[1853]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 23 05:02:57 Sypialnia avahi-daemon[561]: Withdrawing address record for 169.254.117.224 on wlan0. Feb 23 05:02:57 Sypialnia avahi-daemon[561]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.117.224. Feb 23 05:02:57 Sypialnia dhcpcd[673]: wlan0: deleting route to 169.254.0.0/16 Feb 23 05:02:57 Sypialnia avahi-daemon[561]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.201. Feb 23 05:02:57 Sypialnia ntpd[1853]: Listen normally on 2 lo 127.0.0.1:123 Feb 23 05:02:57 Sypialnia ntpd[1853]: Listen normally on 3 wlan0 10.0.0.201:123 Feb 23 05:02:57 Sypialnia ntpd[1853]: Listening on routing socket on fd #20 for interface updates Feb 23 05:02:57 Sypialnia ntpd[1853]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 23 05:02:57 Sypialnia ntpd[1853]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 23 05:02:58 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioGetState Feb 23 05:02:58 Sypialnia volumio[1233]: info: CorePlayQueue::getTrack 0 Feb 23 05:02:58 Sypialnia go-librespot[1597]: time="2026-02-23T05:02:58+01:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Feb 23 05:02:58 Sypialnia systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 23 05:02:58 Sypialnia systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 23 05:02:58 Sypialnia volumio[1233]: info: Discovery: adding 1ebc4039-03ca-4a13-8517-67c519d909a3 Feb 23 05:02:58 Sypialnia volumio[1233]: info: Discovery: Found device Salon Feb 23 05:02:58 Sypialnia volumio[1233]: info: Discovery: Connecting to remote: 10.0.0.200 Feb 23 05:02:58 Sypialnia volumio[1233]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 23 05:02:58 Sypialnia volumio[1233]: info: Discovery: Connected to remote: 10.0.0.200 Feb 23 05:02:58 Sypialnia volumio[1233]: info: Received Get System Info Feb 23 05:02:58 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 05:02:58 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 05:02:58 Sypialnia volumio[1233]: info: Discovery: Getting this device information Feb 23 05:02:58 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioGetState Feb 23 05:02:58 Sypialnia volumio[1233]: info: CorePlayQueue::getTrack 0 Feb 23 05:02:58 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 05:02:58 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 23 05:02:58 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 23 05:02:58 Sypialnia volumio5-onboarding[1510]: time=2026-02-23T05:02:58.492+01:00 level=INFO msg="BLE descriptor updated" deviceId=6bc61afcb5a7bbea87624c9286324aa2 deviceName=Sypialnia deviceModel= Feb 23 05:02:58 Sypialnia volumio5-onboarding[1510]: time=2026-02-23T05:02:58.493+01:00 level=INFO msg="mDNS descriptor updated" deviceId=6bc61afcb5a7bbea87624c9286324aa2 deviceName=Sypialnia deviceModel= Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 23 05:02:58 Sypialnia volumio[1233]: info: Adding plugin bluetooth to MyMusic Plugins Feb 23 05:02:58 Sypialnia volumio[1233]: info: Adding plugin multiroom to MyMusic Plugins Feb 23 05:02:58 Sypialnia volumio[1233]: info: Adding plugin metavolumio to MyMusic Plugins Feb 23 05:02:58 Sypialnia volumio[1233]: info: Adding plugin cd_controller to MyMusic Plugins Feb 23 05:02:58 Sypialnia volumio[1233]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 23 05:02:58 Sypialnia volumio[1233]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 23 05:02:58 Sypialnia volumio[1233]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 23 05:02:58 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 23 05:02:59 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 23 05:02:59 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 23 05:02:59 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 05:02:59 Sypialnia volumio[1233]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 05:02:59 Sypialnia volumio[1233]: info: Starting MyVolumio Remote Streaming Endpoints Feb 23 05:02:59 Sypialnia volumio[1233]: info: MyVolumio login type: Token Feb 23 05:02:59 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 23 05:02:59 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 23 05:03:00 Sypialnia volumio[1233]: info: Starting Streaming Service Transparent Proxy Feb 23 05:03:00 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 23 05:03:00 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 23 05:03:00 Sypialnia volumio[1233]: info: Streaming services startup Feb 23 05:03:00 Sypialnia volumio[1233]: info: Starting Streaming Daemon Feb 23 05:03:00 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 23 05:03:00 Sypialnia sudo[1877]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 23 05:03:00 Sypialnia sudo[1877]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:03:00 Sypialnia sudo[1877]: pam_unix(sudo:session): session closed for user root Feb 23 05:03:00 Sypialnia volumio[1233]: error: Cannot start Volumio Streaming Daemon Feb 23 05:03:00 Sypialnia volumio[1233]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 23 05:03:00 Sypialnia volumio[1233]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 23 05:03:00 Sypialnia volumio[1233]: STREAMING PROXY: Starting server on port 3245 Feb 23 05:03:00 Sypialnia volumio[1233]: Node JS runtime: 14 Feb 23 05:03:00 Sypialnia volumio[1233]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 23 05:03:01 Sypialnia volumio[1233]: info: Initializing connection to go-librespot Websocket Feb 23 05:03:01 Sypialnia volumio[1233]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 23 05:03:01 Sypialnia systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Feb 23 05:03:01 Sypialnia systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Feb 23 05:03:01 Sypialnia systemd[1]: Stopped go-librespot Daemon. Feb 23 05:03:01 Sypialnia systemd[1]: Started go-librespot Daemon. Feb 23 05:03:01 Sypialnia go-librespot[1928]: go-librespot daemon starting... Feb 23 05:03:01 Sypialnia go-librespot[1928]: time="2026-02-23T05:03:01+01:00" level=info msg="running go-librespot 0.4.0" Feb 23 05:03:01 Sypialnia go-librespot[1928]: time="2026-02-23T05:03:01+01:00" level=debug msg="app state loaded" Feb 23 05:03:01 Sypialnia go-librespot[1928]: time="2026-02-23T05:03:01+01:00" level=debug msg="stored credentials not found" Feb 23 05:03:01 Sypialnia go-librespot[1928]: time="2026-02-23T05:03:01+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 23 05:03:01 Sypialnia go-librespot[1928]: time="2026-02-23T05:03:01+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 23 05:03:01 Sypialnia go-librespot[1928]: time="2026-02-23T05:03:01+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 23 05:03:01 Sypialnia go-librespot[1928]: time="2026-02-23T05:03:01+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 23 05:03:01 Sypialnia go-librespot[1928]: time="2026-02-23T05:03:01+01:00" level=info msg="zeroconf server listening on port 33538" Feb 23 05:03:01 Sypialnia volumio[1233]: info: MyVolumio token set successfully Feb 23 05:03:01 Sypialnia volumio[1233]: info: MYVOLUMIO: Adding device Feb 23 05:03:01 Sypialnia volumio[1233]: info: MYVOLUMIO: Evaluating Server Feb 23 05:03:02 Sypialnia volumio-time-update[549]: volumio-time-update-util: Setting system time to: 2026-02-23 05:03:00 Feb 23 05:03:02 Sypialnia volumio[1233]: info: Upgrading User Account from device code Feb 23 05:03:02 Sypialnia volumio[1233]: info: MyVolumio Plan changed: superstar Feb 23 05:03:02 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Feb 23 05:03:02 Sypialnia volumio[1233]: info: Adding audio output: Feb 23 05:03:02 Sypialnia sudo[1958]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2026-02-23 05:03:00 Feb 23 05:03:02 Sypialnia volumio[1233]: info: MYVOLUMIO: Adding device Feb 23 05:03:02 Sypialnia volumio[1233]: info: MYVOLUMIO: Evaluating Server Feb 23 05:03:02 Sypialnia sudo[1958]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:03:02 Sypialnia volumio[1233]: info: Remote config written successfully Feb 23 05:03:02 Sypialnia volumio[1233]: info: Starting Tunnel 1 Feb 23 05:03:02 Sypialnia volumio[1233]: info: Starting Tunnel Connection Checker Feb 23 05:03:02 Sypialnia volumio[1233]: info: Completed starting MyVolumio Plugin Feb 23 05:03:02 Sypialnia dbus-daemon[545]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.13' (uid=0 pid=1963 comm="timedatectl set-time 2026-02-23 05:03:00 ") Feb 23 05:03:02 Sypialnia systemd[1]: Starting Time & Date Service... Feb 23 05:03:02 Sypialnia volumio[1233]: info: Discovery: adding c19b7fb9-4be2-4380-9596-8a80e910cd61 Feb 23 05:03:02 Sypialnia volumio[1233]: info: Discovery: Found device Sypialnia Feb 23 05:03:02 Sypialnia volumio[1233]: info: CoreCommandRouter::volumioGetState Feb 23 05:03:02 Sypialnia volumio[1233]: info: CorePlayQueue::getTrack 0 Feb 23 05:03:02 Sypialnia dbus-daemon[545]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 23 05:03:02 Sypialnia systemd[1]: Started Time & Date Service. Feb 23 05:03:00 Sypialnia systemd-timedated[1964]: Changed local time to Mon Feb 23 05:03:00 2026 Feb 23 05:03:00 Sypialnia sudo[1958]: pam_unix(sudo:session): session closed for user root Feb 23 05:03:00 Sypialnia volumio-time-update[549]: volumio-time-update-util: System time updated successfully. Feb 23 05:03:00 Sypialnia systemd[1]: Started Volumio Time Update Utility. Feb 23 05:03:00 Sypialnia systemd[1]: Reached target Multi-User System. Feb 23 05:03:00 Sypialnia systemd[1]: Reached target Graphical Interface. Feb 23 05:03:00 Sypialnia systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 23 05:03:00 Sypialnia systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 23 05:03:00 Sypialnia systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 23 05:03:00 Sypialnia systemd[1]: Startup finished in 14.272s (kernel) + 1min 3.297s (userspace) = 1min 17.569s. Feb 23 05:03:00 Sypialnia volumio[1233]: info: MYVolumio Device enabled Feb 23 05:03:00 Sypialnia volumio[1233]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Feb 23 05:03:00 Sypialnia volumio[1233]: info: MyVolumio status changed Feb 23 05:03:00 Sypialnia volumio[1233]: info: Streaming services startup Feb 23 05:03:00 Sypialnia volumio[1233]: info: Starting Streaming Daemon Feb 23 05:03:00 Sypialnia volumio[1233]: error: Failed to ping endpoint as2.myvolumio.org : unknown error Feb 23 05:03:00 Sypialnia volumio[1233]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 05:03:00 Sypialnia sudo[1995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 23 05:03:00 Sypialnia volumio[1233]: Error: Unable to resolve or reject the same promise twice Feb 23 05:03:00 Sypialnia volumio[1233]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Feb 23 05:03:00 Sypialnia volumio[1233]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Feb 23 05:03:00 Sypialnia volumio[1233]: at Socket.emit (events.js:412:35) Feb 23 05:03:00 Sypialnia volumio[1233]: at endReadableNT (internal/streams/readable.js:1333:12) Feb 23 05:03:00 Sypialnia volumio[1233]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Feb 23 05:03:00 Sypialnia volumio[1233]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 05:03:00 Sypialnia sudo[1995]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 05:03:00 Sypialnia sudo[1995]: pam_unix(sudo:session): session closed for user root Feb 23 05:03:00 Sypialnia sudo[2013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-23 05:02 Feb 23 05:03:00 Sypialnia sudo[2013]: 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="58e9bc1d7073d86e583c7b0145c7ac1a2c50cfc4" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 16 Jan 2026 05:47:16 PM CET" VOLUMIO_VERSION="3.896" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="21b2cc7976866473d2294c76221b0ebb"