-- Logs begin at Thu 2025-05-22 12:26:47 +07, end at Thu 2025-05-22 12:43:37 +07. -- May 22 12:42:04 volumio volumio[1217]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf May 22 12:42:04 volumio systemd[1]: Starting Cleanup of Temporary Directories... May 22 12:42:04 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. May 22 12:42:04 volumio systemd[1]: Started Cleanup of Temporary Directories. May 22 12:42:07 volumio volumio[1217]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf May 22 12:42:07 volumio volumio[1217]: info: Folder /tmp/plugins removed May 22 12:42:07 volumio volumio[1217]: info: Check plugin dependencies May 22 12:42:07 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 22 12:42:07 volumio volumio[1217]: info: Checking if plugin already exists May 22 12:42:07 volumio volumio[1217]: info: Rename folder May 22 12:42:07 volumio volumio[1217]: info: Folder /tmp/downloaded_plugin.zip removed May 22 12:42:07 volumio volumio[1217]: info: Move to category May 22 12:42:07 volumio volumio[1217]: info: Checking if install.sh is present May 22 12:42:07 volumio volumio[1217]: info: Executing install.sh May 22 12:42:07 volumio sudo[5796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh May 22 12:42:07 volumio sudo[5796]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 12:42:07 volumio volumio[1217]: info: Installing Go-librespot May 22 12:42:07 volumio volumio[1217]: info: Checking old vollibrespot installs May 22 12:42:07 volumio systemd[1]: Reloading. May 22 12:42:07 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 22 12:42:08 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. May 22 12:42:08 volumio systemd[1]: serial-getty@ttyAMA10.service: Current command vanished from the unit file, execution of the command list won't be resumed. May 22 12:42:08 volumio volumio[1217]: info: Downloading daemon May 22 12:42:10 volumio ntpd[1087]: Soliciting pool server 115.165.161.155 May 22 12:42:14 volumio ntpd[1087]: Soliciting pool server 115.165.161.155 May 22 12:42:19 volumio ntpd[1087]: Soliciting pool server 103.184.124.254 May 22 12:42:43 volumio sudo[5871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 22 12:42:43 volumio sudo[5871]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 12:42:43 volumio sudo[5871]: pam_unix(sudo:session): session closed for user root May 22 12:42:43 volumio sudo[5874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 22 12:42:43 volumio sudo[5874]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 12:42:43 volumio sudo[5874]: pam_unix(sudo:session): session closed for user root May 22 12:42:43 volumio volumio[1217]: verbose: New Socket.io Connection to 192.168.1.99 from 192.168.1.1 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 16_6 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.6 Mobile/15E148 Safari/604.1 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::volumioGetVisibleSources May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::volumioGetState May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 22 12:42:43 volumio volumio[1217]: info: Received Get System Info May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 12:42:43 volumio volumio[1217]: info: Discovery: Getting this device information May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::volumioGetState May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::volumioGetState May 22 12:42:43 volumio volumio[1217]: info: Listing playlists May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 22 12:42:43 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 22 12:42:43 volumio volumio[1217]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sonny%20Rollins/Alfie/a112ed99-150d-4a62-b952-0df320e36fde.jpg' May 22 12:42:44 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 22 12:42:45 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 22 12:42:45 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 12:42:45 volumio volumio[1217]: info: Received Get System Info May 22 12:42:45 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 12:42:45 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 12:42:45 volumio volumio[1217]: info: Discovery: Getting this device information May 22 12:42:45 volumio volumio[1217]: info: CoreCommandRouter::volumioGetState May 22 12:42:45 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 12:42:46 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 12:42:46 volumio volumio[1217]: info: Received Get System Info May 22 12:42:46 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 12:42:46 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 12:42:46 volumio volumio[1217]: info: Discovery: Getting this device information May 22 12:42:46 volumio volumio[1217]: info: CoreCommandRouter::volumioGetState May 22 12:42:46 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 12:42:53 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 22 12:42:54 volumio volumio[1217]: info: Enabling plugin spop May 22 12:42:54 volumio volumio[1217]: info: Loading plugin "spop"... May 22 12:42:54 volumio volumio[1217]: info: PLUGIN START: spop May 22 12:42:54 volumio volumio[1217]: info: Creating Spotify config file May 22 12:42:54 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 12:42:54 volumio volumio[1217]: info: Done. May 22 12:42:54 volumio volumio[1217]: error: Failed to write spotify config file: Error: ENOENT: no such file or directory, open '/data/go-librespot/config.yml' May 22 12:42:54 volumio volumio[1217]: error: Error initializing go-librespot daemon: Error: ENOENT: no such file or directory, open '/data/go-librespot/config.yml' May 22 12:42:54 volumio volumio[1217]: info: No need to fix Spotify hosts May 22 12:42:56 volumio volumio[1217]: info: CoreCommandRouter::getUIConfigOnPlugin May 22 12:43:02 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 22 12:43:02 volumio volumio[1217]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 22 12:43:02 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 22 12:43:02 volumio volumio[1217]: info: Received Get System Version May 22 12:43:02 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 22 12:43:02 volumio volumio[1217]: info: Received Get System Info May 22 12:43:02 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 22 12:43:02 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 22 12:43:02 volumio volumio[1217]: info: Discovery: Getting this device information May 22 12:43:02 volumio volumio[1217]: info: CoreCommandRouter::volumioGetState May 22 12:43:02 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 12:43:13 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 22 12:43:13 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 22 12:43:15 volumio ntpd[1087]: Soliciting pool server 115.165.161.155 May 22 12:43:19 volumio ntpd[1087]: Soliciting pool server 115.165.161.155 May 22 12:43:24 volumio ntpd[1087]: Soliciting pool server 2400:e920:0:5::14 May 22 12:43:36 volumio volumio[1217]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 22 12:43:36 volumio volumio[1217]: Error: connect ETIMEDOUT 151.101.130.79:443 May 22 12:43:36 volumio volumio[1217]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 22 12:43:36 volumio volumio[1217]: errno: -110, May 22 12:43:36 volumio volumio[1217]: code: 'ETIMEDOUT', May 22 12:43:36 volumio volumio[1217]: syscall: 'connect', May 22 12:43:36 volumio volumio[1217]: address: '151.101.130.79', May 22 12:43:36 volumio volumio[1217]: port: 443 May 22 12:43:36 volumio volumio[1217]: } May 22 12:43:36 volumio volumio[1217]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 22 12:43:37 volumio sudo[6019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-22 12:42 May 22 12:43:37 volumio sudo[6019]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"