-- Logs begin at Thu 2024-04-04 14:33:50 UTC, end at Thu 2024-04-04 14:35:45 UTC. --
Apr 04 14:34:00 volumio ntpd[703]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Apr 04 14:34:00 volumio sudo[755]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:00 volumio sudo[757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Apr 04 14:34:00 volumio sudo[757]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:00 volumio sudo[757]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:00 volumio sudo[764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Apr 04 14:34:00 volumio sudo[764]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:00 volumio sudo[764]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:00 volumio sudo[766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Apr 04 14:34:00 volumio sudo[766]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:00 volumio systemd[1]: apt-daily.service: Succeeded.
Apr 04 14:34:00 volumio systemd[1]: Started Daily apt download activities.
Apr 04 14:34:00 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
Apr 04 14:34:01 volumio ntpd[703]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Apr 04 14:34:01 volumio sudo[766]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:01 volumio wireless.js[441]: SETTING APPROPRIATE REG DOMAIN: EU
Apr 04 14:34:01 volumio sudo[819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Apr 04 14:34:01 volumio sudo[819]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:01 volumio sudo[819]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:01 volumio sudo[821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set EU
Apr 04 14:34:01 volumio sudo[821]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:01 volumio sudo[821]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:01 volumio wireless.js[441]: SUCCESSFULLY SET NEW REGDOMAIN: EU
Apr 04 14:34:01 volumio wireless.js[441]: Start wireless flow
Apr 04 14:34:01 volumio systemd-udevd[825]: Process '/sbin/crda' failed with exit code 255.
Apr 04 14:34:01 volumio wireless.js[441]: Stopped hotspot (if there)..
Apr 04 14:34:01 volumio sudo[828]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Apr 04 14:34:01 volumio sudo[828]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:01 volumio sudo[828]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:01 volumio sudo[830]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Apr 04 14:34:01 volumio sudo[830]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:01 volumio sudo[830]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:01 volumio wireless.js[441]: DHCP IP
Apr 04 14:34:01 volumio wireless.js[441]: Start ap
Apr 04 14:34:01 volumio wpa_supplicant[832]: Successfully initialized wpa_supplicant
Apr 04 14:34:01 volumio sudo[833]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Apr 04 14:34:01 volumio sudo[833]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:01 volumio kernel: rtl8192cu: MAC auto ON okay!
Apr 04 14:34:01 volumio dhcpcd[834]: sending commands to master dhcpcd process
Apr 04 14:34:01 volumio dhcpcd[515]: control command: /sbin/dhcpcd
Apr 04 14:34:01 volumio sudo[833]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:01 volumio kernel: rtl8192cu: Tx queue select: 0x05
Apr 04 14:34:02 volumio ntpd[703]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Apr 04 14:34:02 volumio volumio-remote-updater[439]: [2024-04-04 14:34:02] [info] asio async_connect error: system:111 (Connection refused)
Apr 04 14:34:02 volumio volumio-remote-updater[439]: [2024-04-04 14:34:02] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 04 14:34:02 volumio volumio-remote-updater[439]: [2024-04-04 14:34:02] [error] handle_connect error: Underlying Transport Error
Apr 04 14:34:02 volumio systemd[1]: apt-daily-upgrade.service: Succeeded.
Apr 04 14:34:02 volumio systemd[1]: Started Daily apt upgrade and clean activities.
Apr 04 14:34:02 volumio wireless.js[441]: trying...
Apr 04 14:34:02 volumio sudo[866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:02 volumio sudo[866]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:02 volumio sudo[866]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:03 volumio wpa_supplicant[859]: wlan0: SME: Trying to authenticate with 38:43:7d:8a:22:29 (SSID='UPC3063175' freq=2462 MHz)
Apr 04 14:34:03 volumio kernel: wlan0: authenticate with 38:43:7d:8a:22:29
Apr 04 14:34:03 volumio kernel: wlan0: 80 MHz not supported, disabling VHT
Apr 04 14:34:03 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 1/3)
Apr 04 14:34:03 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 2/3)
Apr 04 14:34:03 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 3/3)
Apr 04 14:34:03 volumio wireless.js[441]: trying...
Apr 04 14:34:03 volumio sudo[869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:03 volumio sudo[869]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:03 volumio sudo[869]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:03 volumio kernel: wlan0: authentication with 38:43:7d:8a:22:29 timed out
Apr 04 14:34:04 volumio wireless.js[441]: trying...
Apr 04 14:34:04 volumio sudo[872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:04 volumio sudo[872]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:04 volumio sudo[872]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:04 volumio wpa_supplicant[859]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Apr 04 14:34:04 volumio wpa_supplicant[859]: wlan0: SME: Trying to authenticate with 38:43:7d:8a:22:29 (SSID='UPC3063175' freq=2462 MHz)
Apr 04 14:34:04 volumio kernel: wlan0: authenticate with 38:43:7d:8a:22:29
Apr 04 14:34:04 volumio kernel: wlan0: 80 MHz not supported, disabling VHT
Apr 04 14:34:04 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 1/3)
Apr 04 14:34:04 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 2/3)
Apr 04 14:34:05 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 3/3)
Apr 04 14:34:05 volumio kernel: wlan0: authentication with 38:43:7d:8a:22:29 timed out
Apr 04 14:34:05 volumio wireless.js[441]: trying...
Apr 04 14:34:05 volumio sudo[875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:05 volumio sudo[875]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:05 volumio sudo[875]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:06 volumio wpa_supplicant[859]: wlan0: SME: Trying to authenticate with 38:43:7d:8a:22:29 (SSID='UPC3063175' freq=2462 MHz)
Apr 04 14:34:06 volumio kernel: wlan0: authenticate with 38:43:7d:8a:22:29
Apr 04 14:34:06 volumio kernel: wlan0: 80 MHz not supported, disabling VHT
Apr 04 14:34:06 volumio wireless.js[441]: trying...
Apr 04 14:34:06 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 1/3)
Apr 04 14:34:06 volumio sudo[878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:06 volumio sudo[878]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:06 volumio sudo[878]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:06 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 2/3)
Apr 04 14:34:06 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 3/3)
Apr 04 14:34:07 volumio kernel: wlan0: authentication with 38:43:7d:8a:22:29 timed out
Apr 04 14:34:07 volumio wireless.js[441]: trying...
Apr 04 14:34:07 volumio sudo[881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:07 volumio sudo[881]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:07 volumio sudo[881]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:08 volumio wireless.js[441]: trying...
Apr 04 14:34:08 volumio sudo[884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:08 volumio sudo[884]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:08 volumio sudo[884]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:09 volumio wpa_supplicant[859]: wlan0: SME: Trying to authenticate with 38:43:7d:8a:22:29 (SSID='UPC3063175' freq=2462 MHz)
Apr 04 14:34:09 volumio kernel: wlan0: authenticate with 38:43:7d:8a:22:29
Apr 04 14:34:09 volumio kernel: wlan0: 80 MHz not supported, disabling VHT
Apr 04 14:34:09 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 1/3)
Apr 04 14:34:09 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 2/3)
Apr 04 14:34:09 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 3/3)
Apr 04 14:34:09 volumio kernel: wlan0: authentication with 38:43:7d:8a:22:29 timed out
Apr 04 14:34:09 volumio wpa_supplicant[859]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="UPC3063175" auth_failures=1 duration=10 reason=CONN_FAILED
Apr 04 14:34:09 volumio wireless.js[441]: trying...
Apr 04 14:34:09 volumio sudo[887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:09 volumio sudo[887]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:09 volumio sudo[887]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:09 volumio volumio-remote-updater[439]: [2024-04-04 14:34:09] [info] asio async_connect error: system:111 (Connection refused)
Apr 04 14:34:09 volumio volumio-remote-updater[439]: [2024-04-04 14:34:09] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 04 14:34:09 volumio volumio-remote-updater[439]: [2024-04-04 14:34:09] [error] handle_connect error: Underlying Transport Error
Apr 04 14:34:10 volumio wireless.js[441]: trying...
Apr 04 14:34:10 volumio sudo[890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:10 volumio sudo[890]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:10 volumio sudo[890]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:11 volumio wireless.js[441]: trying...
Apr 04 14:34:11 volumio sudo[893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:11 volumio sudo[893]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:11 volumio sudo[893]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:12 volumio wireless.js[441]: trying...
Apr 04 14:34:12 volumio sudo[896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:12 volumio sudo[896]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:12 volumio sudo[896]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:13 volumio wireless.js[441]: trying...
Apr 04 14:34:13 volumio sudo[899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:13 volumio sudo[899]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:13 volumio sudo[899]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:14 volumio wireless.js[441]: trying...
Apr 04 14:34:14 volumio sudo[902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:14 volumio sudo[902]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:14 volumio sudo[902]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:15 volumio wireless.js[441]: trying...
Apr 04 14:34:15 volumio sudo[905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:15 volumio sudo[905]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:15 volumio sudo[905]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:16 volumio wireless.js[441]: trying...
Apr 04 14:34:16 volumio sudo[908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:16 volumio sudo[908]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:16 volumio sudo[908]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:17 volumio wireless.js[441]: trying...
Apr 04 14:34:17 volumio sudo[911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:17 volumio sudo[911]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:17 volumio sudo[911]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:18 volumio wireless.js[441]: trying...
Apr 04 14:34:18 volumio sudo[914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:18 volumio sudo[914]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:18 volumio sudo[914]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:19 volumio wpa_supplicant[859]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="UPC3063175"
Apr 04 14:34:19 volumio wpa_supplicant[859]: wlan0: SME: Trying to authenticate with 38:43:7d:8a:22:29 (SSID='UPC3063175' freq=2462 MHz)
Apr 04 14:34:19 volumio kernel: wlan0: authenticate with 38:43:7d:8a:22:29
Apr 04 14:34:19 volumio kernel: wlan0: 80 MHz not supported, disabling VHT
Apr 04 14:34:19 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 1/3)
Apr 04 14:34:19 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 2/3)
Apr 04 14:34:19 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 3/3)
Apr 04 14:34:19 volumio kernel: wlan0: authentication with 38:43:7d:8a:22:29 timed out
Apr 04 14:34:19 volumio wpa_supplicant[859]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="UPC3063175" auth_failures=2 duration=23 reason=CONN_FAILED
Apr 04 14:34:19 volumio wireless.js[441]: trying...
Apr 04 14:34:19 volumio sudo[917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:19 volumio sudo[917]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:19 volumio sudo[917]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:19 volumio volumio-remote-updater[439]: [2024-04-04 14:34:19] [info] asio async_connect error: system:111 (Connection refused)
Apr 04 14:34:19 volumio volumio-remote-updater[439]: [2024-04-04 14:34:19] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Apr 04 14:34:19 volumio volumio-remote-updater[439]: [2024-04-04 14:34:19] [error] handle_connect error: Underlying Transport Error
Apr 04 14:34:20 volumio wireless.js[441]: trying...
Apr 04 14:34:20 volumio sudo[920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:20 volumio sudo[920]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:20 volumio sudo[920]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:21 volumio wireless.js[441]: trying...
Apr 04 14:34:21 volumio sudo[923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 04 14:34:21 volumio sudo[923]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:21 volumio sudo[923]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:22 volumio wireless.js[441]: Overtime, starting plan B
Apr 04 14:34:22 volumio iwconfig[927]: Error for wireless request "Set Power Management" (8B2C) :
Apr 04 14:34:22 volumio iwconfig[927]: SET failed on device wlan0 ; Operation not supported.
Apr 04 14:34:22 volumio systemd[1]: Started Wireless Services.
Apr 04 14:34:22 volumio systemd[1]: Started Volumio Backend Module.
Apr 04 14:34:22 volumio systemd[1]: Started Start Volumio Kiosk.
Apr 04 14:34:22 volumio systemd[1]: Started Volumio Cpu Tweaker.
Apr 04 14:34:22 volumio systemd[1]: Started Intel SST and HDA soundcard init service.
Apr 04 14:34:22 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Apr 04 14:34:22 volumio volumio-cpu-tweak[930]: Setting RT Priority for mpd
Apr 04 14:34:22 volumio volumio-cpu-tweak[930]: pid 35's current scheduling policy: SCHED_OTHER
Apr 04 14:34:22 volumio volumio-cpu-tweak[930]: pid 35's current scheduling priority: 0
Apr 04 14:34:22 volumio volumio-cpu-tweak[930]: Not enough cores to set MPD affinity
Apr 04 14:34:22 volumio volumio-cpu-tweak[930]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Apr 04 14:34:22 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded.
Apr 04 14:34:23 volumio startx[929]: X.Org X Server 1.20.4
Apr 04 14:34:23 volumio startx[929]: X Protocol Version 11, Revision 0
Apr 04 14:34:23 volumio startx[929]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian
Apr 04 14:34:23 volumio startx[929]: Current Operating System: Linux volumio 6.6.7-volumio #2 SMP PREEMPT_DYNAMIC Mon Dec 18 16:22:28 CET 2023 x86_64
Apr 04 14:34:23 volumio startx[929]: Kernel command line: BOOT_IMAGE=vmlinuz biosdevname=0 splash plymouth.ignore-serial-consoles quiet ro rootwait imgpart=UUID=8cefff0e-76d4-43ed-bbda-2f3225b0ae7d bootpart=UUID=71FA-A851 datapart=UUID=a1b6af07-1d09-4d09-b299-f175484889a8 imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor use_kmsg=yes net.ifnames=0 loglevel=0 initrd=volumio.initrd
Apr 04 14:34:23 volumio startx[929]: Build Date: 18 December 2021 09:05:36AM
Apr 04 14:34:23 volumio startx[929]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support)
Apr 04 14:34:23 volumio startx[929]: Current version of pixman: 0.36.0
Apr 04 14:34:23 volumio startx[929]: Before reporting problems, check http://wiki.x.org
Apr 04 14:34:23 volumio startx[929]: to make sure that you have the latest version.
Apr 04 14:34:23 volumio startx[929]: Markers: (--) probed, (**) from config file, (==) default setting,
Apr 04 14:34:23 volumio startx[929]: (++) from command line, (!!) notice, (II) informational,
Apr 04 14:34:23 volumio startx[929]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Apr 04 14:34:23 volumio startx[929]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu Apr 4 14:34:23 2024
Apr 04 14:34:23 volumio startx[929]: (==) Using config directory: "/etc/X11/xorg.conf.d"
Apr 04 14:34:23 volumio startx[929]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Apr 04 14:34:23 volumio startx[929]: (II) [KMS] Kernel modesetting enabled.
Apr 04 14:34:24 volumio systemd[1]: soundcard-init.service: Succeeded.
Apr 04 14:34:24 volumio sh[403]: timed out
Apr 04 14:34:24 volumio sh[403]: dhcpcd exited
Apr 04 14:34:24 volumio dhcpcd[431]: timed out
Apr 04 14:34:24 volumio dhcpcd[431]: dhcpcd exited
Apr 04 14:34:24 volumio sh[403]: ifup: failed to bring up eth0
Apr 04 14:34:24 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:34:24 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Apr 04 14:34:24 volumio dhcpcd[1096]: sending commands to master dhcpcd process
Apr 04 14:34:24 volumio ifplugd(eth0)[712]: client: sending commands to master dhcpcd process
Apr 04 14:34:24 volumio dhcpcd[515]: control command: /sbin/dhcpcd eth0
Apr 04 14:34:24 volumio ifplugd(eth0)[712]: Program executed successfully.
Apr 04 14:34:24 volumio ifplugd[683]: Network Interface Plugging Daemon...start eth0...done.
Apr 04 14:34:24 volumio systemd[1]: Started LSB: Brings up/down network automatically.
Apr 04 14:34:25 volumio volumio[928]: info: -------------------------------------------
Apr 04 14:34:25 volumio volumio[928]: info: ----- Volumio3 ----
Apr 04 14:34:25 volumio volumio[928]: info: -------------------------------------------
Apr 04 14:34:25 volumio volumio[928]: info: ----- System startup ----
Apr 04 14:34:25 volumio volumio[928]: info: -------------------------------------------
Apr 04 14:34:26 volumio volumio[928]: info: MYVOLUMIO Environment detected
Apr 04 14:34:27 volumio volumio[928]: info: Plugin folders cleanup
Apr 04 14:34:27 volumio volumio[928]: info: Scanning into folder /volumio/app/plugins/
Apr 04 14:34:27 volumio volumio[928]: info: Scanning category audio_interface
Apr 04 14:34:27 volumio volumio[928]: info: Scanning category miscellanea
Apr 04 14:34:27 volumio volumio[928]: info: Scanning category music_service
Apr 04 14:34:27 volumio volumio[928]: info: Scanning category plugins.json
Apr 04 14:34:27 volumio volumio[928]: info: Scanning category system_controller
Apr 04 14:34:27 volumio volumio[928]: info: Scanning category user_interface
Apr 04 14:34:27 volumio volumio[928]: info: Scanning into folder /data/plugins/
Apr 04 14:34:27 volumio volumio[928]: info: Scanning category music_service
Apr 04 14:34:27 volumio volumio[928]: info: Scanning category system_controller
Apr 04 14:34:27 volumio volumio[928]: info: Scanning category user_interface
Apr 04 14:34:27 volumio volumio[928]: info: Plugin folders cleanup completed
Apr 04 14:34:27 volumio volumio[928]: info: -------------------------------------------
Apr 04 14:34:27 volumio volumio[928]: info: ----- Core plugins startup ----
Apr 04 14:34:27 volumio volumio[928]: info: -------------------------------------------
Apr 04 14:34:27 volumio volumio[928]: info: Loading plugins from folder /volumio/app/plugins/
Apr 04 14:34:27 volumio volumio[928]: info: Adding plugin upnp to MyMusic Plugins
Apr 04 14:34:27 volumio volumio[928]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 04 14:34:27 volumio volumio[928]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 04 14:34:27 volumio volumio[928]: info: Loading plugins from folder /data/plugins/
Apr 04 14:34:27 volumio volumio[928]: info: Loading plugin "system"...
Apr 04 14:34:27 volumio volumio[928]: info: Loading plugin "appearance"...
Apr 04 14:34:29 volumio volumio-remote-updater[439]: [2024-04-04 14:34:29] [connect] Successful connection
Apr 04 14:34:29 volumio volumio[928]: info: Loading plugin "network"...
Apr 04 14:34:29 volumio volumio[928]: info: Refreshing Cached IP Addresses
Apr 04 14:34:30 volumio sudo[1200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 04 14:34:30 volumio sudo[1198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 04 14:34:30 volumio volumio[928]: info: Loading plugin "services"...
Apr 04 14:34:30 volumio sudo[1198]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:30 volumio sudo[1200]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:30 volumio sudo[1200]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:30 volumio sudo[1198]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:30 volumio volumio[928]: info: Loading plugin "alsa_controller"...
Apr 04 14:34:30 volumio sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 04 14:34:30 volumio sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:30 volumio sudo[1202]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:30 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 14:34:30 volumio volumio[928]: info: Loading plugin "wizard"...
Apr 04 14:34:30 volumio volumio[928]: info: Loading plugin "networkfs"...
Apr 04 14:34:30 volumio volumio[928]: info: Starting Udev Watcher for removable devices
Apr 04 14:34:30 volumio volumio[928]: info: Ignoring mount for partition: boot
Apr 04 14:34:30 volumio volumio[928]: info: Ignoring mount for partition: volumio
Apr 04 14:34:30 volumio volumio[928]: info: Ignoring mount for partition: volumio_data
Apr 04 14:34:30 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 04 14:34:30 volumio volumio[928]: info: Loading plugin "volumio_command_line_client"...
Apr 04 14:34:30 volumio sudo[1209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=krzysiu.c1971@gmail.com,password=IzaCol2828,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.123/NAS Public/muzyka /mnt/NAS/xigmanas
Apr 04 14:34:30 volumio sudo[1209]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:30 volumio volumio[928]: info: Loading plugin "upnp"...
Apr 04 14:34:30 volumio volumio[928]: info: [1712241270351] Starting Upmpd Daemon
Apr 04 14:34:30 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 04 14:34:30 volumio volumio[928]: info: Loading plugin "my_music"...
Apr 04 14:34:30 volumio kernel: FS-Cache: Loaded
Apr 04 14:34:30 volumio kernel: Key type dns_resolver registered
Apr 04 14:34:30 volumio volumio[928]: info: Loading plugin "mpd"...
Apr 04 14:34:30 volumio kernel: Key type cifs.spnego registered
Apr 04 14:34:30 volumio kernel: Key type cifs.idmap registered
Apr 04 14:34:30 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount.
Apr 04 14:34:30 volumio kernel: CIFS: Attempting to mount //192.168.0.123/NAS Public/muzyka
Apr 04 14:34:30 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Apr 04 14:34:30 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101
Apr 04 14:34:30 volumio sudo[1209]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:30 volumio volumio[928]: info: Loading plugin "upnp_browser"...
Apr 04 14:34:31 volumio volumio[928]: info: Loading plugin "alarm-clock"...
Apr 04 14:34:31 volumio volumio[928]: info: Plugin airplay_emulation is not enabled
Apr 04 14:34:31 volumio volumio[928]: info: Loading plugin "last_100"...
Apr 04 14:34:31 volumio volumio[928]: info: Loading plugin "webradio"...
Apr 04 14:34:31 volumio volumio[928]: info: Loading plugin "i2s_dacs"...
Apr 04 14:34:31 volumio volumio[928]: info: I2S DAC not set, start Auto-detection
Apr 04 14:34:31 volumio volumio[928]: info: Loading plugin "volumiodiscovery"...
Apr 04 14:34:31 volumio volumio[928]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 04 14:34:31 volumio volumio[928]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 14:34:31 volumio node[928]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 04 14:34:31 volumio volumio[928]: *** WARNING *** For more information see
Apr 04 14:34:31 volumio volumio[928]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 04 14:34:31 volumio volumio[928]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 14:34:31 volumio node[928]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 14:34:31 volumio volumio[928]: *** WARNING *** For more information see
Apr 04 14:34:31 volumio node[928]: *** WARNING *** For more information see
Apr 04 14:34:31 volumio node[928]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 04 14:34:31 volumio node[928]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 04 14:34:31 volumio node[928]: *** WARNING *** For more information see
Apr 04 14:34:31 volumio volumio[928]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 04 14:34:31 volumio volumio[928]: info: Discovery: Started advertising with name: Volumio
Apr 04 14:34:31 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 04 14:34:31 volumio volumio[928]: info: Loading plugin "calmradio"...
Apr 04 14:34:32 volumio dbus-daemon[436]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.8' (uid=0 pid=1171 comm="/usr/lib/chromium/chromium --show-component-extens")
Apr 04 14:34:32 volumio systemd[1]: Starting Bluetooth service...
Apr 04 14:34:32 volumio volumio[928]: info: Loading plugin "spop"...
Apr 04 14:34:33 volumio kernel: Bluetooth: Core ver 2.22
Apr 04 14:34:33 volumio kernel: NET: Registered PF_BLUETOOTH protocol family
Apr 04 14:34:33 volumio kernel: Bluetooth: HCI device and connection manager initialized
Apr 04 14:34:33 volumio kernel: Bluetooth: HCI socket layer initialized
Apr 04 14:34:33 volumio kernel: Bluetooth: L2CAP socket layer initialized
Apr 04 14:34:33 volumio kernel: Bluetooth: SCO socket layer initialized
Apr 04 14:34:33 volumio bluetoothd[1242]: Bluetooth daemon 5.50
Apr 04 14:34:33 volumio bluetoothd[1242]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Apr 04 14:34:33 volumio dbus-daemon[436]: [system] Successfully activated service 'org.bluez'
Apr 04 14:34:33 volumio systemd[1]: Started Bluetooth service.
Apr 04 14:34:33 volumio bluetoothd[1242]: Starting SDP server
Apr 04 14:34:33 volumio bluetoothd[1242]: Excluding (cli) sap
Apr 04 14:34:33 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Apr 04 14:34:33 volumio kernel: Bluetooth: BNEP filters: protocol multicast
Apr 04 14:34:33 volumio kernel: Bluetooth: BNEP socket layer initialized
Apr 04 14:34:33 volumio bluetoothd[1242]: Bluetooth management interface 1.22 initialized
Apr 04 14:34:33 volumio dbus-daemon[436]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.9' (uid=0 pid=1242 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Apr 04 14:34:33 volumio systemd[1]: Starting Hostname Service...
Apr 04 14:34:33 volumio dbus-daemon[436]: [system] Successfully activated service 'org.freedesktop.hostname1'
Apr 04 14:34:33 volumio systemd[1]: Started Hostname Service.
Apr 04 14:34:35 volumio volumio[928]: info: Loading plugin "autostart"...
Apr 04 14:34:35 volumio volumio[928]: info: Applying required configuration parameters for plugin autostart
Apr 04 14:34:35 volumio volumio[928]: info: AutoStart - onVolumioStart - read config.json
Apr 04 14:34:35 volumio volumio[928]: info: Loading plugin "now_playing"...
Apr 04 14:34:36 volumio volumio[928]: info: Loading plugin "outputs"...
Apr 04 14:34:36 volumio volumio[928]: info: Loading plugin "albumart"...
Apr 04 14:34:36 volumio volumio[928]: info: Plugin example_plugin is not enabled
Apr 04 14:34:36 volumio volumio[928]: info: Loading plugin "inputs"...
Apr 04 14:34:36 volumio volumio[928]: info: Loading plugin "updater_comm"...
Apr 04 14:34:37 volumio volumio[928]: info: Plugin mpdemulation is not enabled
Apr 04 14:34:37 volumio volumio[928]: info: Loading plugin "rest_api"...
Apr 04 14:34:37 volumio volumio[928]: Forking 1 albumart workers
Apr 04 14:34:37 volumio volumio[928]: info: Loading plugin "websocket"...
Apr 04 14:34:37 volumio volumio[928]: info: Loading plugin "80s80s"...
Apr 04 14:34:37 volumio volumio[928]: info: Applying required configuration parameters for plugin 80s80s
Apr 04 14:34:37 volumio volumio[928]: info: [1712241277437] [80s80s] API delay: 30
Apr 04 14:34:37 volumio volumio[928]: info: Loading plugin "nowyswiat"...
Apr 04 14:34:37 volumio volumio[928]: Starting albumart workers
Apr 04 14:34:37 volumio volumio[928]: info: Applying required configuration parameters for plugin nowyswiat
Apr 04 14:34:37 volumio volumio[928]: info: [1712241277688] [RadioNowySwiat] API delay: 5
Apr 04 14:34:37 volumio volumio[928]: info: [1712241277689] [RadioNowySwiat] Stream 256Kb: http://stream.rcs.revma.com/ypqt40u0x1zuv
Apr 04 14:34:37 volumio volumio[928]: info: Loading plugin "rad357pl"...
Apr 04 14:34:37 volumio volumio[928]: info: Applying required configuration parameters for plugin rad357pl
Apr 04 14:34:37 volumio volumio[928]: info: [1712241277992] [rad357pl] API delay: 5
Apr 04 14:34:37 volumio volumio[928]: info: Loading plugin "radio_paradise"...
Apr 04 14:34:38 volumio volumio[928]: info: Applying required configuration parameters for plugin radio_paradise
Apr 04 14:34:38 volumio volumio[928]: info: [1712241278220] [RadioParadise] API delay: 5
Apr 04 14:34:38 volumio volumio[928]: info: Loading i18n strings for locale pl
Apr 04 14:34:38 volumio volumio[928]: Updating browse sources language
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::initPlayerControls
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 14:34:38 volumio volumio[928]: Express server listening on port 3000
Apr 04 14:34:38 volumio volumio[928]: [Metrics] WebUI: 13s 583.84ms
Apr 04 14:34:38 volumio volumio[928]: info: Setting Device type: x86
Apr 04 14:34:38 volumio volumio[928]: info: CoreStateMachine::resetVolumioState
Apr 04 14:34:38 volumio volumio[928]: info: CoreStateMachine::getcurrentVolume
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::volumioRetrievevolume
Apr 04 14:34:38 volumio volumio[928]: info: CoreStateMachine::pushState
Apr 04 14:34:38 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::volumioPushState
Apr 04 14:34:38 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 14:34:38 volumio volumio[928]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Apr 04 14:34:38 volumio volumio[928]: info: Completed loading Core Plugins
Apr 04 14:34:38 volumio volumio[928]: info: Preparing to generate the ALSA configuration file
Apr 04 14:34:38 volumio volumio[928]: info: Cannot mount NAS xigmanas at system boot, trial number 1 ,retrying in 5 seconds
Apr 04 14:34:38 volumio volumio[928]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Apr 04 14:34:38 volumio volumio[928]: wlan0 Interface doesn't support scanning : Device or resource busy
Apr 04 14:34:38 volumio volumio[928]: info: Cannot use regular scanning, forcing with ap-force
Apr 04 14:34:38 volumio sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Apr 04 14:34:38 volumio sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:39 volumio sudo[1387]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:39 volumio volumio[928]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Apr 04 14:34:39 volumio volumio[928]: info: Reloading queue from file
Apr 04 14:34:39 volumio volumio[928]: info: CoreStateMachine::setRepeat null single undefined
Apr 04 14:34:39 volumio volumio[928]: info: CoreStateMachine::pushState
Apr 04 14:34:39 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::volumioPushState
Apr 04 14:34:39 volumio volumio[928]: info: CoreStateMachine::setRandom null
Apr 04 14:34:39 volumio volumio[928]: info: CoreStateMachine::pushState
Apr 04 14:34:39 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::volumioPushState
Apr 04 14:34:39 volumio volumio[928]: info: Asound.conf file unchanged, so no further update is needed
Apr 04 14:34:39 volumio volumio[928]: info: Output device has changed, restarting MPD
Apr 04 14:34:39 volumio sudo[1394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 04 14:34:39 volumio sudo[1394]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:39 volumio sudo[1394]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:39 volumio volumio[928]: info: ___________ START PLUGINS ___________
Apr 04 14:34:39 volumio volumio[928]: info: ControllerMpd::onStart: Initializing MPD
Apr 04 14:34:39 volumio volumio[928]: info: Creating MPD Configuration file
Apr 04 14:34:39 volumio sudo[1397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 04 14:34:39 volumio sudo[1397]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:39 volumio systemd[1]: Listening on mpd.socket.
Apr 04 14:34:39 volumio systemd[1]: Starting Music Player Daemon...
Apr 04 14:34:39 volumio sudo[1400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 04 14:34:39 volumio sudo[1400]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 14:34:39 volumio sudo[1400]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:39 volumio sudo[1404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 04 14:34:39 volumio volumio[928]: info: [1712241279780] CoreMusicLibrary::Adding element Serwery MediĆ³w
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 14:34:39 volumio sudo[1404]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:39 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 04 14:34:39 volumio systemd[1]: mpd.service: Succeeded.
Apr 04 14:34:39 volumio systemd[1]: Stopped Music Player Daemon.
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 14:34:39 volumio volumio[928]: info: [1712241279819] CoreMusicLibrary::Adding element Last_100
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 14:34:39 volumio volumio[928]: info: [1712241279821] CoreMusicLibrary::Adding element Webradio
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 14:34:39 volumio volumio[928]: info: Adding Calm Radio to Browse Sources
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 14:34:39 volumio systemd[1]: Starting Music Player Daemon...
Apr 04 14:34:39 volumio volumio[928]: info: [1712241279830] CoreMusicLibrary::Adding element Calm Radio
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source Calm Radio
Apr 04 14:34:39 volumio volumio[928]: info: Creating Spotify config file
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:39 volumio volumio[928]: info: AutoStart - onStart
Apr 04 14:34:39 volumio volumio[928]: info: [now-playing] ConfigUpdater: config is up to date.
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 14:34:39 volumio volumio[928]: info: [1712241279875] CoreMusicLibrary::Adding element 80s80s Radio
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source Calm Radio
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source 80s80s Radio
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 14:34:39 volumio volumio[928]: info: [1712241279881] CoreMusicLibrary::Adding element Radio Nowy Swiat
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source Calm Radio
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source 80s80s Radio
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source Radio Nowy Swiat
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 14:34:39 volumio volumio[928]: info: [1712241279888] CoreMusicLibrary::Adding element RADIO 357
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source Calm Radio
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source 80s80s Radio
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source Radio Nowy Swiat
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source RADIO 357
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 04 14:34:39 volumio volumio[928]: info: [1712241279894] CoreMusicLibrary::Adding element Radio Paradise
Apr 04 14:34:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source Calm Radio
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source 80s80s Radio
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source Radio Nowy Swiat
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source RADIO 357
Apr 04 14:34:39 volumio volumio[928]: Cannot find translation for source Radio Paradise
Apr 04 14:34:39 volumio volumio[928]: info: Volumio Calling Home
Apr 04 14:34:40 volumio volumio[928]: info: [now-playing] App is listening on port 4004.
Apr 04 14:34:40 volumio volumio[928]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds
Apr 04 14:34:40 volumio volumio[928]: Unhandled rejection Error: No sockets available, cannot start.
Apr 04 14:34:40 volumio volumio[928]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11)
Apr 04 14:34:40 volumio volumio[928]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10)
Apr 04 14:34:40 volumio volumio[928]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10
Apr 04 14:34:40 volumio volumio[928]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9)
Apr 04 14:34:40 volumio volumio[928]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18)
Apr 04 14:34:40 volumio volumio[928]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10)
Apr 04 14:34:40 volumio volumio[928]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10)
Apr 04 14:34:40 volumio volumio[928]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17)
Apr 04 14:34:40 volumio volumio[928]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12)
Apr 04 14:34:40 volumio volumio[928]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24)
Apr 04 14:34:40 volumio volumio[928]: at HashMap. (/volumio/app/pluginmanager.js:496:31)
Apr 04 14:34:40 volumio volumio[928]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Apr 04 14:34:40 volumio volumio[928]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Apr 04 14:34:40 volumio volumio[928]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20)
Apr 04 14:34:40 volumio volumio[928]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29)
Apr 04 14:34:40 volumio volumio[928]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 04 14:34:40 volumio volumio[928]: info: MPD Permissions set
Apr 04 14:34:40 volumio volumio[928]: info: Spotify config file written
Apr 04 14:34:40 volumio volumio[928]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:40 volumio sudo[1411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Apr 04 14:34:40 volumio sudo[1411]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:40 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:34:40 volumio go-librespot[1414]: Librespot-go daemon starting...
Apr 04 14:34:40 volumio sudo[1411]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:34:40 volumio sudo[1432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 04 14:34:40 volumio sudo[1434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 04 14:34:40 volumio sudo[1434]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:40 volumio sudo[1432]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:40 volumio go-librespot[1414]: time="2024-04-04T14:34:40Z" level=info msg="generated new device id: 9f07903a322471197ac5ec8231a40edb0bf8af57"
Apr 04 14:34:40 volumio sudo[1432]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:40 volumio go-librespot[1414]: time="2024-04-04T14:34:40Z" 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"
Apr 04 14:34:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:34:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:34:40 volumio sudo[1434]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:40 volumio volumio[928]: info: CoreCommandRouter::volumioGetState
Apr 04 14:34:40 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:34:40 volumio sudo[1438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 04 14:34:40 volumio sudo[1438]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:40 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 04 14:34:40 volumio sudo[1438]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:40 volumio volumio[928]: info: Upmpdcli Daemon Started
Apr 04 14:34:41 volumio mpd[1406]: Apr 04 14:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 04 14:34:41 volumio systemd[1]: Started Music Player Daemon.
Apr 04 14:34:41 volumio sudo[1397]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:41 volumio sudo[1404]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:41 volumio volumio[928]: info: Completed starting Core Plugins
Apr 04 14:34:41 volumio volumio[928]: info: -------------------------------------------
Apr 04 14:34:41 volumio volumio[928]: info: ----- MyVolumio plugins startup ----
Apr 04 14:34:41 volumio volumio[928]: info: -------------------------------------------
Apr 04 14:34:41 volumio volumio[928]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 04 14:34:41 volumio volumio[928]: error: MPD error: The expression evaluated to a falsy value:
Apr 04 14:34:41 volumio volumio[928]: assert.ok(self.idling)
Apr 04 14:34:41 volumio volumio[928]: error: The expression evaluated to a falsy value:
Apr 04 14:34:41 volumio volumio[928]: assert.ok(self.idling)
Apr 04 14:34:41 volumio volumio[928]: info: MPD running with PID1406
Apr 04 14:34:41 volumio volumio[928]: ,establishing connection
Apr 04 14:34:41 volumio volumio[928]: error: updateQueue error: null
Apr 04 14:34:41 volumio volumio[928]: error: updateQueue error: null
Apr 04 14:34:42 volumio wpa_supplicant[859]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="UPC3063175"
Apr 04 14:34:42 volumio wpa_supplicant[859]: wlan0: SME: Trying to authenticate with 38:43:7d:8a:22:29 (SSID='UPC3063175' freq=2462 MHz)
Apr 04 14:34:42 volumio kernel: wlan0: authenticate with 38:43:7d:8a:22:29
Apr 04 14:34:42 volumio kernel: wlan0: 80 MHz not supported, disabling VHT
Apr 04 14:34:42 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 1/3)
Apr 04 14:34:42 volumio kernel: wlan0: authenticated
Apr 04 14:34:42 volumio wpa_supplicant[859]: wlan0: Trying to associate with 38:43:7d:8a:22:29 (SSID='UPC3063175' freq=2462 MHz)
Apr 04 14:34:42 volumio kernel: wlan0: associate with 38:43:7d:8a:22:29 (try 1/3)
Apr 04 14:34:42 volumio kernel: wlan0: associate with 38:43:7d:8a:22:29 (try 2/3)
Apr 04 14:34:43 volumio kernel: wlan0: associate with 38:43:7d:8a:22:29 (try 3/3)
Apr 04 14:34:43 volumio kernel: wlan0: association with 38:43:7d:8a:22:29 timed out
Apr 04 14:34:43 volumio wpa_supplicant[859]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="UPC3063175" auth_failures=3 duration=46 reason=CONN_FAILED
Apr 04 14:34:43 volumio volumio[928]: info: go-librespot daemon successfully initialized
Apr 04 14:34:43 volumio sudo[1635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=krzysiu.c1971@gmail.com,password=IzaCol2828,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.123/NAS Public/muzyka /mnt/NAS/xigmanas
Apr 04 14:34:43 volumio sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:43 volumio kernel: CIFS: Attempting to mount //192.168.0.123/NAS Public/muzyka
Apr 04 14:34:43 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Apr 04 14:34:43 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101
Apr 04 14:34:43 volumio sudo[1635]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:43 volumio volumio[928]: info: Cannot mount NAS xigmanas at system boot, trial number 2 ,retrying in 5 seconds
Apr 04 14:34:43 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:34:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1.
Apr 04 14:34:43 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:34:43 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:34:43 volumio go-librespot[1639]: Librespot-go daemon starting...
Apr 04 14:34:43 volumio go-librespot[1639]: time="2024-04-04T14:34:43Z" level=info msg="generated new device id: e4f1b319a1241f7bc271edf5457bb483c77c977b"
Apr 04 14:34:43 volumio go-librespot[1639]: time="2024-04-04T14:34:43Z" 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"
Apr 04 14:34:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:34:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:34:44 volumio volumio-remote-updater[439]: [2024-04-04 14:34:44] [connect] Successful connection
Apr 04 14:34:44 volumio volumio-remote-updater[439]: [2024-04-04 14:34:44] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1712241284 101
Apr 04 14:34:44 volumio volumio[928]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2
Apr 04 14:34:46 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:34:46 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:34:46 volumio volumio[928]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Apr 04 14:34:46 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:34:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2.
Apr 04 14:34:46 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:34:46 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:34:46 volumio go-librespot[1645]: Librespot-go daemon starting...
Apr 04 14:34:46 volumio go-librespot[1645]: time="2024-04-04T14:34:46Z" level=info msg="generated new device id: 7ba4ed36cb8f9ca5dc8343e5dea30a2709b0b5e6"
Apr 04 14:34:46 volumio go-librespot[1645]: time="2024-04-04T14:34:46Z" 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"
Apr 04 14:34:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:34:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:34:48 volumio sudo[1652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=krzysiu.c1971@gmail.com,password=IzaCol2828,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.123/NAS Public/muzyka /mnt/NAS/xigmanas
Apr 04 14:34:48 volumio sudo[1652]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:48 volumio sudo[1652]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:48 volumio kernel: CIFS: Attempting to mount //192.168.0.123/NAS Public/muzyka
Apr 04 14:34:48 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Apr 04 14:34:48 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101
Apr 04 14:34:48 volumio volumio[928]: info: Cannot mount NAS xigmanas at system boot, trial number 3 ,retrying in 5 seconds
Apr 04 14:34:49 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:34:49 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:34:50 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:34:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3.
Apr 04 14:34:50 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:34:50 volumio volumio[928]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.634&uuid=764ceda24ceb3895705ab712646e4622" http://updates.volumio.org/downloader-v1/track-device
Apr 04 14:34:50 volumio volumio[928]: % Total % Received % Xferd Average Speed Time Time Time Current
Apr 04 14:34:50 volumio volumio[928]: Dload Upload Total Spent Left Speed
Apr 04 14:34:50 volumio volumio[928]: [132B blob data]
Apr 04 14:34:50 volumio volumio[928]: retrying in 5 seconds, trial 0
Apr 04 14:34:50 volumio volumio[928]: info: Volumio Calling Home
Apr 04 14:34:50 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:34:50 volumio go-librespot[1656]: Librespot-go daemon starting...
Apr 04 14:34:50 volumio go-librespot[1656]: time="2024-04-04T14:34:50Z" level=info msg="generated new device id: 660829021f6755cd7d2ed9188c423076c1c3de3e"
Apr 04 14:34:50 volumio go-librespot[1656]: time="2024-04-04T14:34:50Z" 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"
Apr 04 14:34:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:34:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:34:52 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:34:52 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:34:53 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:34:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4.
Apr 04 14:34:53 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:34:53 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:34:53 volumio go-librespot[1665]: Librespot-go daemon starting...
Apr 04 14:34:53 volumio go-librespot[1665]: time="2024-04-04T14:34:53Z" level=info msg="generated new device id: 41ef6b6f0642d025ce35ef7bd58f768d644ff58c"
Apr 04 14:34:53 volumio go-librespot[1665]: time="2024-04-04T14:34:53Z" 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"
Apr 04 14:34:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:34:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:34:53 volumio sudo[1672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=krzysiu.c1971@gmail.com,password=IzaCol2828,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.123/NAS Public/muzyka /mnt/NAS/xigmanas
Apr 04 14:34:53 volumio sudo[1672]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:53 volumio kernel: CIFS: Attempting to mount //192.168.0.123/NAS Public/muzyka
Apr 04 14:34:53 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Apr 04 14:34:53 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101
Apr 04 14:34:53 volumio sudo[1672]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:53 volumio volumio[928]: info: Cannot mount NAS xigmanas at system boot, trial number 4 ,retrying in 5 seconds
Apr 04 14:34:55 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:34:55 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:34:56 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:34:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5.
Apr 04 14:34:56 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:34:56 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:34:56 volumio go-librespot[1705]: Librespot-go daemon starting...
Apr 04 14:34:56 volumio go-librespot[1705]: time="2024-04-04T14:34:56Z" level=info msg="generated new device id: 72349dc6187c109a3b557414afe831193b3766c4"
Apr 04 14:34:56 volumio go-librespot[1705]: time="2024-04-04T14:34:56Z" 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"
Apr 04 14:34:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:34:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:34:58 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:34:58 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:34:58 volumio sudo[1712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=krzysiu.c1971@gmail.com,password=IzaCol2828,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.123/NAS Public/muzyka /mnt/NAS/xigmanas
Apr 04 14:34:58 volumio sudo[1712]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:34:58 volumio sudo[1712]: pam_unix(sudo:session): session closed for user root
Apr 04 14:34:58 volumio kernel: CIFS: Attempting to mount //192.168.0.123/NAS Public/muzyka
Apr 04 14:34:58 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Apr 04 14:34:58 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101
Apr 04 14:34:58 volumio volumio[928]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Apr 04 14:34:59 volumio volumio[928]: info: AutoStart - Plugin is starting
Apr 04 14:34:59 volumio volumio[928]: info: CoreCommandRouter::volumioGetQueue
Apr 04 14:34:59 volumio volumio[928]: info: CoreStateMachine::getQueue
Apr 04 14:34:59 volumio volumio[928]: info: CorePlayQueue::getQueue
Apr 04 14:34:59 volumio volumio[928]: info: AutoStart - start playing
Apr 04 14:34:59 volumio volumio[928]: info: AutoStart - start playing with no specific position
Apr 04 14:34:59 volumio volumio[928]: info: CoreCommandRouter::volumioPlay
Apr 04 14:34:59 volumio volumio[928]: info: CoreStateMachine::play index 0
Apr 04 14:34:59 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 04 14:34:59 volumio volumio[928]: info: CoreStateMachine::stop
Apr 04 14:34:59 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 04 14:34:59 volumio volumio[928]: info: CoreStateMachine::play index undefined
Apr 04 14:34:59 volumio volumio[928]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 04 14:34:59 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:34:59 volumio volumio[928]: info: CoreStateMachine::startPlaybackTimer
Apr 04 14:34:59 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:34:59 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand stop
Apr 04 14:34:59 volumio volumio[928]: info: sendMpdCommand stop took 1 milliseconds
Apr 04 14:34:59 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand clear
Apr 04 14:34:59 volumio volumio[928]: info:
Apr 04 14:34:59 volumio volumio[928]: ---------------------------- MPD announces system playlist update
Apr 04 14:34:59 volumio volumio[928]: info: Ignoring MPD Status Update
Apr 04 14:34:59 volumio volumio[928]: info: sendMpdCommand clear took 3 milliseconds
Apr 04 14:34:59 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand consume 1
Apr 04 14:34:59 volumio volumio[928]: info:
Apr 04 14:34:59 volumio volumio[928]: ---------------------------- MPD announces system playlist update
Apr 04 14:34:59 volumio volumio[928]: info: Ignoring MPD Status Update
Apr 04 14:34:59 volumio volumio[928]: info:
Apr 04 14:34:59 volumio volumio[928]: ---------------------------- MPD announces system playlist update
Apr 04 14:34:59 volumio volumio[928]: info: Ignoring MPD Status Update
Apr 04 14:34:59 volumio volumio[928]: error: updateQueue error: null
Apr 04 14:34:59 volumio volumio[928]: info:
Apr 04 14:34:59 volumio volumio[928]: ---------------------------- MPD announces state update: options
Apr 04 14:34:59 volumio volumio[928]: error: updateQueue error: null
Apr 04 14:34:59 volumio volumio[928]: error: updateQueue error: null
Apr 04 14:34:59 volumio volumio[928]: info: ------------------------------ 8ms
Apr 04 14:34:59 volumio volumio[928]: info: sendMpdCommand consume 1 took 7 milliseconds
Apr 04 14:34:59 volumio volumio[928]: info: ControllerMpd::getState
Apr 04 14:34:59 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand status
Apr 04 14:34:59 volumio volumio[928]: info: ------------------------------ 7ms
Apr 04 14:34:59 volumio volumio[928]: info: ------------------------------ 5ms
Apr 04 14:34:59 volumio volumio[928]: info: [1712241299878] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/flac
Apr 04 14:34:59 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/flac"
Apr 04 14:34:59 volumio volumio[928]: info:
Apr 04 14:34:59 volumio volumio[928]: ---------------------------- MPD announces state update: options
Apr 04 14:34:59 volumio volumio[928]: info: ControllerMpd::getState
Apr 04 14:34:59 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand status
Apr 04 14:34:59 volumio volumio[928]: info:
Apr 04 14:34:59 volumio volumio[928]: ---------------------------- MPD announces state update: options
Apr 04 14:34:59 volumio volumio[928]: info: ControllerMpd::getState
Apr 04 14:34:59 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand status
Apr 04 14:34:59 volumio volumio[928]: info:
Apr 04 14:34:59 volumio volumio[928]: ---------------------------- MPD announces system playlist update
Apr 04 14:34:59 volumio volumio[928]: info: Ignoring MPD Status Update
Apr 04 14:34:59 volumio volumio[928]: info: sendMpdCommand status took 8 milliseconds
Apr 04 14:34:59 volumio volumio[928]: info: sendMpdCommand add "https://stream.radioparadise.com/flac" took 7 milliseconds
Apr 04 14:34:59 volumio volumio[928]: info: sendMpdCommand status took 6 milliseconds
Apr 04 14:34:59 volumio volumio[928]: info: sendMpdCommand status took 4 milliseconds
Apr 04 14:34:59 volumio volumio[928]: verbose: ControllerMpd::parseState
Apr 04 14:34:59 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand play
Apr 04 14:34:59 volumio volumio[928]: verbose: ControllerMpd::parseState
Apr 04 14:34:59 volumio volumio[928]: verbose: ControllerMpd::parseState
Apr 04 14:34:59 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:34:59 volumio volumio[928]: info: ControllerMpd::pushState
Apr 04 14:34:59 volumio volumio[928]: info: CoreCommandRouter::servicePushState
Apr 04 14:34:59 volumio volumio[928]: info: CoreStateMachine::pushState
Apr 04 14:34:59 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:34:59 volumio volumio[928]: info: CoreCommandRouter::volumioPushState
Apr 04 14:34:59 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:34:59 volumio volumio[928]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Apr 04 14:34:59 volumio volumio[928]: info: ControllerMpd::pushState
Apr 04 14:34:59 volumio volumio[928]: info: CoreCommandRouter::servicePushState
Apr 04 14:34:59 volumio volumio[928]: info: CoreStateMachine::pushState
Apr 04 14:34:59 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:34:59 volumio volumio[928]: info: CoreCommandRouter::volumioPushState
Apr 04 14:34:59 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:34:59 volumio volumio[928]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Apr 04 14:34:59 volumio volumio[928]: info: ControllerMpd::pushState
Apr 04 14:34:59 volumio volumio[928]: info: CoreCommandRouter::servicePushState
Apr 04 14:34:59 volumio volumio[928]: info: CoreStateMachine::pushState
Apr 04 14:34:59 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:34:59 volumio volumio[928]: info: CoreCommandRouter::volumioPushState
Apr 04 14:34:59 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:34:59 volumio volumio[928]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Apr 04 14:34:59 volumio volumio[928]: info: ------------------------------ 36ms
Apr 04 14:34:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 6.
Apr 04 14:34:59 volumio volumio[928]: info: ------------------------------ 37ms
Apr 04 14:34:59 volumio volumio[928]: info: ------------------------------ 36ms
Apr 04 14:34:59 volumio volumio[928]: info:
Apr 04 14:34:59 volumio volumio[928]: ---------------------------- MPD announces system playlist update
Apr 04 14:34:59 volumio volumio[928]: info: Ignoring MPD Status Update
Apr 04 14:34:59 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:34:59 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:34:59 volumio volumio[928]: info:
Apr 04 14:34:59 volumio volumio[928]: ---------------------------- MPD announces system playlist update
Apr 04 14:34:59 volumio volumio[928]: info: Ignoring MPD Status Update
Apr 04 14:34:59 volumio go-librespot[1716]: Librespot-go daemon starting...
Apr 04 14:34:59 volumio volumio[928]: info: ------------------------------ 48ms
Apr 04 14:34:59 volumio volumio[928]: info: sendMpdCommand play took 41 milliseconds
Apr 04 14:34:59 volumio volumio[928]: info: ------------------------------ 11ms
Apr 04 14:34:59 volumio volumio[928]: info: ------------------------------ 13ms
Apr 04 14:34:59 volumio volumio[928]: info: [1712241299937] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0
Apr 04 14:34:59 volumio go-librespot[1716]: time="2024-04-04T14:34:59Z" level=info msg="generated new device id: 1a99a5cf1fe9c73e30ae7edc3dd6eacaba855223"
Apr 04 14:34:59 volumio go-librespot[1716]: time="2024-04-04T14:34:59Z" 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"
Apr 04 14:34:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:34:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:34:59 volumio volumio[928]: info: [1712241299956] [RadioParadise] Error: getaddrinfo EBUSY api.radioparadise.com
Apr 04 14:35:00 volumio volumio[928]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.634&uuid=764ceda24ceb3895705ab712646e4622" http://updates.volumio.org/downloader-v1/track-device
Apr 04 14:35:00 volumio volumio[928]: % Total % Received % Xferd Average Speed Time Time Time Current
Apr 04 14:35:00 volumio volumio[928]: Dload Upload Total Spent Left Speed
Apr 04 14:35:00 volumio volumio[928]: [132B blob data]
Apr 04 14:35:00 volumio volumio[928]: retrying in 5 seconds, trial 1
Apr 04 14:35:00 volumio volumio[928]: info: Volumio Calling Home
Apr 04 14:35:00 volumio volumio[928]: info:
Apr 04 14:35:00 volumio volumio[928]: ---------------------------- MPD announces state update: player
Apr 04 14:35:00 volumio volumio[928]: info: ControllerMpd::getState
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand status
Apr 04 14:35:00 volumio volumio[928]: info:
Apr 04 14:35:00 volumio volumio[928]: ---------------------------- MPD announces state update: player
Apr 04 14:35:00 volumio volumio[928]: info: ControllerMpd::getState
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand status
Apr 04 14:35:00 volumio volumio[928]: info:
Apr 04 14:35:00 volumio volumio[928]: ---------------------------- MPD announces state update: player
Apr 04 14:35:00 volumio volumio[928]: info: ControllerMpd::getState
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand status
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 04 14:35:00 volumio volumio[928]: info: sendMpdCommand status took 8 milliseconds
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::parseState
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 04 14:35:00 volumio volumio[928]: info: sendMpdCommand status took 11 milliseconds
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 04 14:35:00 volumio volumio[928]: info: sendMpdCommand status took 10 milliseconds
Apr 04 14:35:00 volumio volumio[928]: info: sendMpdCommand clearerror took 7 milliseconds
Apr 04 14:35:00 volumio volumio[928]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::parseState
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::parseState
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::parseTrackInfo
Apr 04 14:35:00 volumio volumio[928]: info: ControllerMpd::pushState
Apr 04 14:35:00 volumio volumio[928]: info: CoreCommandRouter::servicePushState
Apr 04 14:35:00 volumio volumio[928]: info: CoreStateMachine::pushState
Apr 04 14:35:00 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:35:00 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 04 14:35:00 volumio volumio[928]: info: CoreCommandRouter::volumioPushState
Apr 04 14:35:00 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:35:00 volumio volumio[928]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Apr 04 14:35:00 volumio volumio[928]: info: ------------------------------ 31ms
Apr 04 14:35:00 volumio volumio[928]: info: sendMpdCommand clearerror took 22 milliseconds
Apr 04 14:35:00 volumio volumio[928]: info: sendMpdCommand clearerror took 22 milliseconds
Apr 04 14:35:00 volumio volumio[928]: info: sendMpdCommand playlistinfo took 18 milliseconds
Apr 04 14:35:00 volumio volumio[928]: info: sendMpdCommand playlistinfo took 18 milliseconds
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::parseTrackInfo
Apr 04 14:35:00 volumio volumio[928]: verbose: ControllerMpd::parseTrackInfo
Apr 04 14:35:00 volumio volumio[928]: info: ControllerMpd::pushState
Apr 04 14:35:00 volumio volumio[928]: info: CoreCommandRouter::servicePushState
Apr 04 14:35:00 volumio volumio[928]: info: CoreStateMachine::pushState
Apr 04 14:35:00 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:35:00 volumio volumio[928]: info: CoreCommandRouter::volumioPushState
Apr 04 14:35:00 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:35:00 volumio volumio[928]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Apr 04 14:35:00 volumio volumio[928]: info: ControllerMpd::pushState
Apr 04 14:35:00 volumio volumio[928]: info: CoreCommandRouter::servicePushState
Apr 04 14:35:00 volumio volumio[928]: info: CoreStateMachine::pushState
Apr 04 14:35:00 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:35:00 volumio volumio[928]: info: CoreCommandRouter::volumioPushState
Apr 04 14:35:00 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:35:00 volumio volumio[928]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Apr 04 14:35:00 volumio volumio[928]: info: ------------------------------ 47ms
Apr 04 14:35:00 volumio volumio[928]: info: ------------------------------ 46ms
Apr 04 14:35:01 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:01 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:01 volumio volumio[928]: error: MyVolumio Plugin failed to start in a timely fashion
Apr 04 14:35:01 volumio volumio[928]: info: BOOT COMPLETED
Apr 04 14:35:01 volumio volumio[928]: [Metrics] CommandRouter: 35s 933.87ms
Apr 04 14:35:01 volumio volumio[928]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 04 14:35:01 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 04 14:35:01 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 14:35:01 volumio volumio[928]: info: CoreCommandRouter::Close All Modals sent
Apr 04 14:35:01 volumio volumio[928]: info: CoreCommandRouter::Close All Modals sent
Apr 04 14:35:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 04 14:35:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 04 14:35:02 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 04 14:35:03 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:35:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 7.
Apr 04 14:35:03 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:35:03 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:35:03 volumio go-librespot[1736]: Librespot-go daemon starting...
Apr 04 14:35:03 volumio go-librespot[1736]: time="2024-04-04T14:35:03Z" level=info msg="generated new device id: ca7249e5cf1779798efe4f5942557f4aa32c640e"
Apr 04 14:35:03 volumio go-librespot[1736]: time="2024-04-04T14:35:03Z" 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"
Apr 04 14:35:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:35:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:35:03 volumio systemd[1]: systemd-hostnamed.service: Succeeded.
Apr 04 14:35:04 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:04 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:05 volumio ntpd[703]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Apr 04 14:35:06 volumio ntpd[703]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Apr 04 14:35:06 volumio ntpd[703]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Apr 04 14:35:06 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:35:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 8.
Apr 04 14:35:06 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:35:06 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:35:06 volumio go-librespot[1744]: Librespot-go daemon starting...
Apr 04 14:35:06 volumio go-librespot[1744]: time="2024-04-04T14:35:06Z" level=info msg="generated new device id: 3c0c5cb6ae3deaa29823267a894b2f4ebeb1003a"
Apr 04 14:35:06 volumio go-librespot[1744]: time="2024-04-04T14:35:06Z" 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"
Apr 04 14:35:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:35:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:35:07 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:07 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:08 volumio ntpd[703]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Apr 04 14:35:09 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:35:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 9.
Apr 04 14:35:09 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:35:09 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:35:09 volumio go-librespot[1750]: Librespot-go daemon starting...
Apr 04 14:35:09 volumio go-librespot[1750]: time="2024-04-04T14:35:09Z" level=info msg="generated new device id: d27941511ee8abd213dc57c3a6f55d5fbd549c17"
Apr 04 14:35:09 volumio go-librespot[1750]: time="2024-04-04T14:35:09Z" 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"
Apr 04 14:35:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:35:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:35:09 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 04 14:35:09 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 14:35:09 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 04 14:35:10 volumio volumio[928]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.634&uuid=764ceda24ceb3895705ab712646e4622" http://updates.volumio.org/downloader-v1/track-device
Apr 04 14:35:10 volumio volumio[928]: % Total % Received % Xferd Average Speed Time Time Time Current
Apr 04 14:35:10 volumio volumio[928]: Dload Upload Total Spent Left Speed
Apr 04 14:35:10 volumio volumio[928]: [132B blob data]
Apr 04 14:35:10 volumio volumio[928]: retrying in 5 seconds, trial 2
Apr 04 14:35:10 volumio volumio[928]: info: Volumio Calling Home
Apr 04 14:35:10 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:10 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:12 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:35:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10.
Apr 04 14:35:12 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:35:12 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:35:12 volumio go-librespot[1761]: Librespot-go daemon starting...
Apr 04 14:35:12 volumio go-librespot[1761]: time="2024-04-04T14:35:12Z" level=info msg="generated new device id: dd72aeba8dcda1ad7ed30c78d8c38ac9e2f4ec48"
Apr 04 14:35:12 volumio go-librespot[1761]: time="2024-04-04T14:35:12Z" 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"
Apr 04 14:35:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:35:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:35:13 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:13 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:16 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:35:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11.
Apr 04 14:35:16 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:35:16 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:35:16 volumio go-librespot[1767]: Librespot-go daemon starting...
Apr 04 14:35:16 volumio go-librespot[1767]: time="2024-04-04T14:35:16Z" level=info msg="generated new device id: d0e36ec4ab172e9f09ac141ace60622fcf13b37a"
Apr 04 14:35:16 volumio go-librespot[1767]: time="2024-04-04T14:35:16Z" 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"
Apr 04 14:35:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:35:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:35:16 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:16 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:19 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:35:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12.
Apr 04 14:35:19 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:35:19 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:35:19 volumio go-librespot[1773]: Librespot-go daemon starting...
Apr 04 14:35:19 volumio go-librespot[1773]: time="2024-04-04T14:35:19Z" level=info msg="generated new device id: ed7f1ce34d7713836aeaa49df960020838f0a550"
Apr 04 14:35:19 volumio go-librespot[1773]: time="2024-04-04T14:35:19Z" 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"
Apr 04 14:35:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:35:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:35:19 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:19 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:22 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:22 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:35:22 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13.
Apr 04 14:35:22 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:35:22 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:35:22 volumio go-librespot[1779]: Librespot-go daemon starting...
Apr 04 14:35:22 volumio go-librespot[1779]: time="2024-04-04T14:35:22Z" level=info msg="generated new device id: fba11a014dfd762909d208284abb72ffa78629ab"
Apr 04 14:35:22 volumio go-librespot[1779]: time="2024-04-04T14:35:22Z" 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"
Apr 04 14:35:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:35:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:35:25 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:25 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:25 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:35:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14.
Apr 04 14:35:25 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:35:25 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:35:25 volumio go-librespot[1785]: Librespot-go daemon starting...
Apr 04 14:35:25 volumio go-librespot[1785]: time="2024-04-04T14:35:25Z" level=info msg="generated new device id: 825707b267aa0b9db7568c613ea7c6878a0294bb"
Apr 04 14:35:25 volumio go-librespot[1785]: time="2024-04-04T14:35:25Z" 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"
Apr 04 14:35:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:35:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:35:28 volumio systemd[1]: nmbd.service: Start operation timed out. Terminating.
Apr 04 14:35:28 volumio systemd[1]: nmbd.service: Main process exited, code=killed, status=15/TERM
Apr 04 14:35:28 volumio systemd[1]: nmbd.service: Failed with result 'timeout'.
Apr 04 14:35:28 volumio systemd[1]: Failed to start Samba NMB Daemon.
Apr 04 14:35:28 volumio systemd[1]: Starting Samba Winbind Daemon...
Apr 04 14:35:28 volumio winbindd[1791]: [2024/04/04 14:35:28.384919, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Apr 04 14:35:28 volumio winbindd[1791]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Apr 04 14:35:28 volumio winbindd[1791]: [2024/04/04 14:35:28.398930, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Apr 04 14:35:28 volumio systemd[1]: Started Samba Winbind Daemon.
Apr 04 14:35:28 volumio winbindd[1791]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Apr 04 14:35:28 volumio systemd[1]: Starting Samba SMB Daemon...
Apr 04 14:35:28 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:28 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:28 volumio smbd[1795]: [2024/04/04 14:35:28.771285, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Apr 04 14:35:28 volumio systemd[1]: Started Samba SMB Daemon.
Apr 04 14:35:28 volumio smbd[1795]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Apr 04 14:35:28 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:35:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15.
Apr 04 14:35:28 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:35:28 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:35:28 volumio systemd[1]: Reached target Multi-User System.
Apr 04 14:35:28 volumio systemd[1]: Reached target Graphical Interface.
Apr 04 14:35:28 volumio go-librespot[1801]: Librespot-go daemon starting...
Apr 04 14:35:28 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Apr 04 14:35:28 volumio go-librespot[1801]: time="2024-04-04T14:35:28Z" level=info msg="generated new device id: 10c7b302f30bd5b68a7926c8b4b4bbe18a4f56b8"
Apr 04 14:35:28 volumio go-librespot[1801]: time="2024-04-04T14:35:28Z" 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"
Apr 04 14:35:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:35:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:35:28 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Apr 04 14:35:28 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Apr 04 14:35:28 volumio systemd[1]: Startup finished in 22.750s (kernel) + 1min 40.589s (userspace) = 2min 3.339s.
Apr 04 14:35:30 volumio wpa_supplicant[859]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="UPC3063175"
Apr 04 14:35:30 volumio wpa_supplicant[859]: wlan0: SME: Trying to authenticate with 38:43:7d:8a:22:29 (SSID='UPC3063175' freq=2462 MHz)
Apr 04 14:35:30 volumio kernel: wlan0: authenticate with 38:43:7d:8a:22:29
Apr 04 14:35:30 volumio kernel: wlan0: 80 MHz not supported, disabling VHT
Apr 04 14:35:30 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 1/3)
Apr 04 14:35:30 volumio kernel: wlan0: send auth to 38:43:7d:8a:22:29 (try 2/3)
Apr 04 14:35:30 volumio wpa_supplicant[859]: wlan0: Trying to associate with 38:43:7d:8a:22:29 (SSID='UPC3063175' freq=2462 MHz)
Apr 04 14:35:30 volumio kernel: wlan0: authenticated
Apr 04 14:35:30 volumio kernel: wlan0: associate with 38:43:7d:8a:22:29 (try 1/3)
Apr 04 14:35:30 volumio wpa_supplicant[859]: wlan0: Associated with 38:43:7d:8a:22:29
Apr 04 14:35:30 volumio kernel: wlan0: RX AssocResp from 38:43:7d:8a:22:29 (capab=0x1411 status=0 aid=1)
Apr 04 14:35:30 volumio kernel: wlan0: associated
Apr 04 14:35:30 volumio wpa_supplicant[859]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 04 14:35:30 volumio systemd-udevd[1810]: Process '/sbin/crda' failed with exit code 255.
Apr 04 14:35:30 volumio kernel: wlan0: Limiting TX power to 20 (20 - 0) dBm as advertised by 38:43:7d:8a:22:29
Apr 04 14:35:30 volumio wpa_supplicant[859]: wlan0: WPA: Key negotiation completed with 38:43:7d:8a:22:29 [PTK=CCMP GTK=CCMP]
Apr 04 14:35:30 volumio wpa_supplicant[859]: wlan0: CTRL-EVENT-CONNECTED - Connection to 38:43:7d:8a:22:29 completed [id=0 id_str=]
Apr 04 14:35:30 volumio dhcpcd[515]: wlan0: carrier acquired
Apr 04 14:35:30 volumio dhcpcd[515]: wlan0: IAID 7f:b3:2b:ed
Apr 04 14:35:31 volumio dhcpcd[515]: wlan0: rebinding lease of 192.168.0.220
Apr 04 14:35:31 volumio dhcpcd[515]: wlan0: probing address 192.168.0.220/24
Apr 04 14:35:31 volumio dhcpcd[515]: wlan0: soliciting an IPv6 router
Apr 04 14:35:31 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:31 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:31 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:35:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16.
Apr 04 14:35:31 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:35:31 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:35:31 volumio go-librespot[1827]: Librespot-go daemon starting...
Apr 04 14:35:31 volumio go-librespot[1827]: time="2024-04-04T14:35:31Z" level=info msg="generated new device id: a75963c2635ea4c0fa50fed09279f4993ae00ee3"
Apr 04 14:35:31 volumio go-librespot[1827]: time="2024-04-04T14:35:31Z" 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"
Apr 04 14:35:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:35:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:35:33 volumio wpa_supplicant[859]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Apr 04 14:35:34 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:34 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:35 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:35:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17.
Apr 04 14:35:35 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:35:35 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:35:35 volumio go-librespot[1833]: Librespot-go daemon starting...
Apr 04 14:35:35 volumio go-librespot[1833]: time="2024-04-04T14:35:35Z" level=info msg="generated new device id: eab7d12324395226c5e0dcee2a735e92aaad5516"
Apr 04 14:35:35 volumio go-librespot[1833]: time="2024-04-04T14:35:35Z" 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"
Apr 04 14:35:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 04 14:35:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 04 14:35:36 volumio dhcpcd[515]: wlan0: leased 192.168.0.220 for 86400 seconds
Apr 04 14:35:36 volumio dhcpcd[515]: wlan0: adding route to 192.168.0.0/24
Apr 04 14:35:36 volumio dhcpcd[515]: wlan0: adding default route via 192.168.0.1
Apr 04 14:35:36 volumio avahi-daemon[449]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.220.
Apr 04 14:35:36 volumio avahi-daemon[449]: New relevant interface wlan0.IPv4 for mDNS.
Apr 04 14:35:36 volumio avahi-daemon[449]: Registering new address record for 192.168.0.220 on wlan0.IPv4.
Apr 04 14:35:36 volumio ntpd[703]: ntpd exiting on signal 15 (Terminated)
Apr 04 14:35:36 volumio systemd[1]: Stopping Network Time Service...
Apr 04 14:35:36 volumio systemd[1]: ntp.service: Succeeded.
Apr 04 14:35:36 volumio systemd[1]: Stopped Network Time Service.
Apr 04 14:35:36 volumio systemd[1]: Starting Network Time Service...
Apr 04 14:35:36 volumio ntpd[1876]: ntpd 4.2.8p12@1.3728-o (1): Starting
Apr 04 14:35:36 volumio ntpd[1876]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Apr 04 14:35:36 volumio systemd[1]: Started Network Time Service.
Apr 04 14:35:36 volumio ntpd[1882]: proto: precision = 0.164 usec (-22)
Apr 04 14:35:36 volumio ntpd[1882]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Apr 04 14:35:36 volumio ntpd[1882]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Apr 04 14:35:36 volumio ntpd[1882]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 464 days ago
Apr 04 14:35:36 volumio ntpd[1882]: Listen and drop on 0 v6wildcard [::]:123
Apr 04 14:35:36 volumio ntpd[1882]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Apr 04 14:35:36 volumio ntpd[1882]: Listen normally on 2 lo 127.0.0.1:123
Apr 04 14:35:36 volumio ntpd[1882]: Listen normally on 3 wlan0 192.168.0.220:123
Apr 04 14:35:36 volumio ntpd[1882]: Listening on routing socket on fd #20 for interface updates
Apr 04 14:35:36 volumio ntpd[1882]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 04 14:35:36 volumio ntpd[1882]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Apr 04 14:35:37 volumio volumio[928]: info: Discovery: adding bc23ee66-0571-480f-b0f5-6783ddc34ded
Apr 04 14:35:37 volumio volumio[928]: info: Discovery: Found device Volumio
Apr 04 14:35:37 volumio volumio[928]: info: CoreCommandRouter::volumioGetState
Apr 04 14:35:37 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:35:37 volumio ntpd[1882]: Soliciting pool server 185.45.112.121
Apr 04 14:35:37 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:37 volumio volumio[928]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Apr 04 14:35:38 volumio volumio[928]: info: Adding plugin bluetooth to MyMusic Plugins
Apr 04 14:35:38 volumio volumio[928]: info: Adding plugin multiroom to MyMusic Plugins
Apr 04 14:35:38 volumio volumio[928]: info: Adding plugin metavolumio to MyMusic Plugins
Apr 04 14:35:38 volumio volumio[928]: info: Adding plugin cd_controller to MyMusic Plugins
Apr 04 14:35:38 volumio volumio[928]: info: Adding plugin smart_inputs to MyMusic Plugins
Apr 04 14:35:38 volumio volumio[928]: info: Adding plugin tidalconnect to MyMusic Plugins
Apr 04 14:35:38 volumio volumio[928]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Apr 04 14:35:38 volumio ntpd[1882]: Soliciting pool server 95.85.21.89
Apr 04 14:35:38 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 04 14:35:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18.
Apr 04 14:35:38 volumio ntpd[1882]: Soliciting pool server 45.159.204.28
Apr 04 14:35:38 volumio systemd[1]: Stopped go-librespot Daemon.
Apr 04 14:35:38 volumio systemd[1]: Started go-librespot Daemon.
Apr 04 14:35:38 volumio go-librespot[1885]: Librespot-go daemon starting...
Apr 04 14:35:38 volumio go-librespot[1885]: time="2024-04-04T14:35:38Z" level=info msg="generated new device id: 3cf000ec6cbac3fdf19ef7134fb32074b4a04335"
Apr 04 14:35:38 volumio go-librespot[1885]: time="2024-04-04T14:35:38Z" 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-gew1.spotify.com:443 ap-gae2.spotify.com:80]"
Apr 04 14:35:38 volumio go-librespot[1885]: time="2024-04-04T14:35:38Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Apr 04 14:35:38 volumio go-librespot[1885]: time="2024-04-04T14:35:38Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Apr 04 14:35:38 volumio go-librespot[1885]: time="2024-04-04T14:35:38Z" level=debug msg="zeroconf server listening on port 39439"
Apr 04 14:35:39 volumio volumio[928]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Apr 04 14:35:39 volumio volumio[928]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Apr 04 14:35:39 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 04 14:35:39 volumio volumio[928]: info: Starting MyVolumio Remote Streaming Endpoints
Apr 04 14:35:39 volumio volumio[928]: info: MyVolumio login type: Token
Apr 04 14:35:39 volumio volumio[928]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Apr 04 14:35:39 volumio volumio[928]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Apr 04 14:35:39 volumio ntpd[1882]: Soliciting pool server 5.39.184.5
Apr 04 14:35:39 volumio ntpd[1882]: Soliciting pool server 45.138.55.60
Apr 04 14:35:39 volumio ntpd[1882]: Soliciting pool server 185.80.247.36
Apr 04 14:35:39 volumio volumio[1440]: Generating RSA private key, 4096 bit long modulus (2 primes)
Apr 04 14:35:40 volumio volumio[928]: info: Starting Streaming Service Transparent Proxy
Apr 04 14:35:40 volumio volumio[928]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Apr 04 14:35:40 volumio volumio[928]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Apr 04 14:35:40 volumio volumio[928]: info: Streaming services startup
Apr 04 14:35:40 volumio volumio[928]: info: Starting Streaming Daemon
Apr 04 14:35:40 volumio volumio[1440]: ......................++++
Apr 04 14:35:40 volumio sudo[1914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 04 14:35:40 volumio sudo[1914]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:35:40 volumio ntpd[1882]: Soliciting pool server 34.147.28.4
Apr 04 14:35:40 volumio volumio[928]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Apr 04 14:35:40 volumio sudo[1914]: pam_unix(sudo:session): session closed for user root
Apr 04 14:35:40 volumio ntpd[1882]: Soliciting pool server 213.135.57.60
Apr 04 14:35:40 volumio volumio[928]: error: Cannot start Volumio Streaming Daemon
Apr 04 14:35:40 volumio volumio[928]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 04 14:35:40 volumio volumio[928]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 04 14:35:40 volumio volumio[928]: info: Initializing connection to go-librespot Websocket
Apr 04 14:35:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 04 14:35:40 volumio volumio[928]: info: Discovery: Getting this device information
Apr 04 14:35:40 volumio volumio[928]: info: CoreCommandRouter::volumioGetState
Apr 04 14:35:40 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:35:40 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 04 14:35:40 volumio go-librespot[1885]: time="2024-04-04T14:35:40Z" level=debug msg="new websocket client"
Apr 04 14:35:40 volumio volumio[928]: info: Connection to go-librespot Websocket established
Apr 04 14:35:41 volumio volumio[928]: error: MyVolumio Custom Token format not valid, refreshing it
Apr 04 14:35:41 volumio ntpd[1882]: Soliciting pool server 188.165.17.91
Apr 04 14:35:41 volumio ntpd[1882]: Soliciting pool server 158.101.213.248
Apr 04 14:35:41 volumio volumio[928]: STREAMING PROXY: Starting server on port 3245
Apr 04 14:35:41 volumio volumio[928]: Node JS runtime: 14
Apr 04 14:35:41 volumio volumio[1440]: ..............................................++++
Apr 04 14:35:41 volumio volumio[1440]: e is 65537 (0x010001)
Apr 04 14:35:41 volumio volumio[1440]: writing RSA key
Apr 04 14:35:42 volumio volumio[928]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not access weather service: missing geographic coordinates.
Apr 04 14:35:42 volumio volumio[928]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:106:19)
Apr 04 14:35:42 volumio volumio[928]: at Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:113:37)
Apr 04 14:35:42 volumio volumio[928]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:47:13
Apr 04 14:35:42 volumio volumio[928]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5)
Apr 04 14:35:42 volumio volumio[928]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:144:13)
Apr 04 14:35:42 volumio volumio[928]: at Route.dispatch (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:114:3)
Apr 04 14:35:42 volumio volumio[928]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5)
Apr 04 14:35:42 volumio volumio[928]: at /data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:284:15
Apr 04 14:35:42 volumio volumio[928]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:365:14)
Apr 04 14:35:42 volumio volumio[928]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14)
Apr 04 14:35:42 volumio volumio[928]: at Function.process_params (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:421:3)
Apr 04 14:35:42 volumio volumio[928]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:280:10)
Apr 04 14:35:42 volumio volumio[928]: at Function.handle (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:175:3)
Apr 04 14:35:42 volumio volumio[928]: at router (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:47:12)
Apr 04 14:35:42 volumio volumio[928]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5)
Apr 04 14:35:42 volumio volumio[928]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 3
Apr 04 14:35:42 volumio ntpd[1882]: Soliciting pool server 162.159.200.123
Apr 04 14:35:42 volumio volumio[928]: info: MyVolumio login type: Token
Apr 04 14:35:42 volumio volumio[928]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined
Apr 04 14:35:42 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo
Apr 04 14:35:42 volumio volumio[928]: info: Listing playlists
Apr 04 14:35:42 volumio volumio[928]: info: CoreCommandRouter::volumioGetQueue
Apr 04 14:35:42 volumio volumio[928]: info: CoreStateMachine::getQueue
Apr 04 14:35:42 volumio volumio[928]: info: CorePlayQueue::getQueue
Apr 04 14:35:42 volumio volumio[928]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 04 14:35:42 volumio volumio[928]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 04 14:35:42 volumio volumio[928]: info: CoreCommandRouter::volumioGetState
Apr 04 14:35:42 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:35:43 volumio volumio[928]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Apr 04 14:35:43 volumio ntpd[1882]: Soliciting pool server 89.250.197.242
Apr 04 14:35:43 volumio volumio[928]: info: Getting Spotify volume
Apr 04 14:35:43 volumio volumio[928]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4
Apr 04 14:35:43 volumio volumio[928]: info: CoreCommandRouter::volumioGetState
Apr 04 14:35:43 volumio volumio[928]: info: CorePlayQueue::getTrack 0
Apr 04 14:35:44 volumio volumio[928]: info: MyVolumio token set successfully
Apr 04 14:35:44 volumio volumio[928]: info: MYVOLUMIO: Adding device
Apr 04 14:35:44 volumio volumio[928]: info: MYVOLUMIO: Evaluating Server
Apr 04 14:35:45 volumio volumio[928]: info: MyVolumio status changed
Apr 04 14:35:45 volumio volumio[928]: info: Streaming services startup
Apr 04 14:35:45 volumio volumio[928]: info: Starting Streaming Daemon
Apr 04 14:35:45 volumio volumio[928]: info: Removing browser output: myVolumio user plan is not superstar
Apr 04 14:35:45 volumio volumio[928]: info: Removing audio output:
Apr 04 14:35:45 volumio volumio[928]: info: Stoppping Tunnel 1
Apr 04 14:35:45 volumio sudo[1953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 04 14:35:45 volumio sudo[1953]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:35:45 volumio sudo[1953]: pam_unix(sudo:session): session closed for user root
Apr 04 14:35:45 volumio volumio[928]: error: Cannot start Volumio Streaming Daemon
Apr 04 14:35:45 volumio volumio[928]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 04 14:35:45 volumio volumio[928]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 04 14:35:45 volumio sudo[1956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Apr 04 14:35:45 volumio sudo[1956]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 04 14:35:45 volumio sudo[1956]: pam_unix(sudo:session): session closed for user root
Apr 04 14:35:45 volumio volumio[928]: info: Remote SSH Stopped
Apr 04 14:35:45 volumio ntpd[1882]: receive: Unexpected origin timestamp 0xe9b93941.5769dc8d does not match aorg 0000000000.00000000 from server@185.45.112.121 xmt 0xe9b93941.2b4d9ed4
Apr 04 14:35:45 volumio ntpd[1882]: receive: Unexpected origin timestamp 0xe9b93941.5767e302 does not match aorg 0000000000.00000000 from server@95.85.21.89 xmt 0xe9b93941.2cd1e407
Apr 04 14:35:45 volumio ntpd[1882]: receive: Unexpected origin timestamp 0xe9b93941.5760bd25 does not match aorg 0000000000.00000000 from server@188.165.17.91 xmt 0xe9b93941.2b9c657a
Apr 04 14:35:45 volumio volumio[928]: error: Failed to ping endpoint as2.myvolumio.org : unknown error
Apr 04 14:35:45 volumio volumio[928]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 04 14:35:45 volumio volumio[928]: Error: Unable to resolve or reject the same promise twice
Apr 04 14:35:45 volumio volumio[928]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Apr 04 14:35:45 volumio volumio[928]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086)
Apr 04 14:35:45 volumio volumio[928]: at Socket.emit (events.js:412:35)
Apr 04 14:35:45 volumio volumio[928]: at endReadableNT (internal/streams/readable.js:1333:12)
Apr 04 14:35:45 volumio volumio[928]: at processTicksAndRejections (internal/process/task_queues.js:82:21)
Apr 04 14:35:45 volumio volumio[928]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 04 14:35:45 volumio sudo[1968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-04 14:34
Apr 04 14:35:45 volumio sudo[1968]: 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="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET"
VOLUMIO_VERSION="3.634"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"