May 26 08:51:00 volumio2 volumio[1040]: info: Initializing connection to go-librespot Websocket May 26 08:51:00 volumio2 go-librespot[2190]: time="2025-05-26T08:51:00+01:00" level=debug msg="new websocket client" May 26 08:51:00 volumio2 volumio[1040]: info: Connection to go-librespot Websocket established May 26 08:51:02 volumio2 volumio[1040]: info: Enabling plugin spop May 26 08:51:02 volumio2 volumio[1040]: info: Loading plugin "spop"... May 26 08:51:02 volumio2 volumio[1040]: info: PLUGIN START: spop May 26 08:51:02 volumio2 volumio[1040]: info: Creating Spotify config file May 26 08:51:02 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 26 08:51:02 volumio2 volumio[1040]: info: Done. May 26 08:51:02 volumio2 volumio[1040]: info: Spotify config file written May 26 08:51:02 volumio2 volumio[1040]: info: No need to fix Spotify hosts May 26 08:51:02 volumio2 sudo[2199]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service May 26 08:51:02 volumio2 sudo[2199]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:51:02 volumio2 systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... May 26 08:51:02 volumio2 systemd[1]: go-librespot-daemon.service: Deactivated successfully. May 26 08:51:02 volumio2 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 26 08:51:02 volumio2 volumio[1040]: info: Connection to go-librespot Websocket closed May 26 08:51:02 volumio2 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 26 08:51:02 volumio2 go-librespot[2201]: go-librespot daemon starting... May 26 08:51:02 volumio2 sudo[2199]: pam_unix(sudo:session): session closed for user root May 26 08:51:02 volumio2 go-librespot[2202]: time="2025-05-26T08:51:02+01:00" level=info msg="running go-librespot 0.2.0" May 26 08:51:02 volumio2 go-librespot[2202]: time="2025-05-26T08:51:02+01:00" level=debug msg="app state loaded" May 26 08:51:02 volumio2 go-librespot[2202]: time="2025-05-26T08:51:02+01:00" level=debug msg="stored credentials not found" May 26 08:51:02 volumio2 go-librespot[2202]: time="2025-05-26T08:51:02+01:00" level=info msg="api server listening on 127.0.0.1:9879" May 26 08:51:02 volumio2 go-librespot[2202]: time="2025-05-26T08:51:02+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" May 26 08:51:02 volumio2 go-librespot[2202]: time="2025-05-26T08:51:02+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" May 26 08:51:02 volumio2 go-librespot[2202]: time="2025-05-26T08:51:02+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" May 26 08:51:02 volumio2 go-librespot[2202]: time="2025-05-26T08:51:02+01:00" level=info msg="zeroconf server listening on port 45893" May 26 08:51:03 volumio2 volumio[1040]: info: Getting Spotify volume May 26 08:51:03 volumio2 volumio[1040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 26 08:51:03 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:51:03 volumio2 volumio[1040]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29 May 26 08:51:03 volumio2 volumio[1040]: SPOTIFY: SPOTIFY VOLUME undefined May 26 08:51:03 volumio2 volumio[1040]: SPOTIFY: VOLUMIO VOLUME 29 May 26 08:51:03 volumio2 volumio[1040]: info: Aligning Spotify Volume to Volumio Volume May 26 08:51:03 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:51:03 volumio2 volumio[1040]: info: Setting Spotify Volume from Volumio: 29 May 26 08:51:05 volumio2 volumio[1040]: SPOTIFY: SETTING SPOTIFY VOLUME 29 May 26 08:51:05 volumio2 volumio[1040]: info: Sending Spotify command with payload to local API: /player/volume May 26 08:51:05 volumio2 volumio[1040]: info: Initializing connection to go-librespot Websocket May 26 08:51:05 volumio2 go-librespot[2202]: time="2025-05-26T08:51:05+01:00" level=debug msg="new websocket client" May 26 08:51:05 volumio2 volumio[1040]: info: Connection to go-librespot Websocket established May 26 08:51:05 volumio2 volumio[1040]: info: go-librespot daemon successfully initialized May 26 08:51:08 volumio2 volumio[1040]: info: Getting Spotify volume May 26 08:51:08 volumio2 volumio[1040]: info: Initializing connection to go-librespot Websocket May 26 08:51:08 volumio2 volumio[1040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 May 26 08:51:08 volumio2 go-librespot[2202]: time="2025-05-26T08:51:08+01:00" level=debug msg="new websocket client" May 26 08:51:08 volumio2 volumio[1040]: info: Connection to go-librespot Websocket established May 26 08:51:08 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:51:08 volumio2 volumio[1040]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29 May 26 08:51:11 volumio2 volumio[1040]: info: Getting Spotify volume May 26 08:51:11 volumio2 volumio[1040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 May 26 08:51:11 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:51:11 volumio2 volumio[1040]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29 May 26 08:51:11 volumio2 systemd[1]: systemd-timedated.service: Deactivated successfully. May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 26 08:51:14 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 26 08:51:26 volumio2 nmbd[953]: [2025/05/26 08:51:26.680136, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 26 08:51:26 volumio2 nmbd[953]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.127 for name WORKGROUP<1d>. May 26 08:51:26 volumio2 nmbd[953]: This response was from IP 192.168.178.26, reporting an IP address of 192.168.178.26. May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:51:32 volumio2 volumio[1040]: info: Retrieving Cloud Streaming UI May 26 08:51:32 volumio2 volumio[1040]: info: Getting Tidal Cloud Configuration May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:51:32 volumio2 volumio[1040]: info: Getting Qobuz Cloud Configuration May 26 08:51:32 volumio2 volumio[1040]: info: Asking plugin for UI Config May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:51:32 volumio2 volumio[1040]: info: Getting Spotify Cloud Configuration May 26 08:51:32 volumio2 volumio[1040]: info: Asking plugin for UI Config May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:51:32 volumio2 volumio[1040]: info: Saving Spotify Acccount May 26 08:51:32 volumio2 volumio[1040]: info: Got Tidal Cloud Configuration May 26 08:51:32 volumio2 volumio[1040]: info: Got it May 26 08:51:32 volumio2 volumio[1040]: info: Got it May 26 08:51:32 volumio2 volumio[1040]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:51:32 volumio2 volumio[1040]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetBrowseSources May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetBrowseSources May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetBrowseSources May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 08:51:32 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 26 08:51:36 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 08:51:40 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 08:51:44 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 08:51:46 volumio2 volumio[1040]: info: CALLMETHOD: miscellanea my_music updateMusicLibrarySupersearchSources [object Object] May 26 08:51:46 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , updateMusicLibrarySupersearchSources May 26 08:51:47 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetBrowseSources May 26 08:51:47 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetBrowseSources May 26 08:51:47 volumio2 volumio[1040]: info: CoreCommandRouter::updateGlobalSearchableBrowseSources May 26 08:51:48 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 08:51:52 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 08:51:53 volumio2 sudo[2294]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 08:51:53 volumio2 sudo[2294]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:51:53 volumio2 sudo[2294]: pam_unix(sudo:session): session closed for user root May 26 08:51:53 volumio2 sudo[2296]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 08:51:53 volumio2 sudo[2296]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:51:53 volumio2 sudo[2296]: pam_unix(sudo:session): session closed for user root May 26 08:51:53 volumio2 volumio[1040]: verbose: New Socket.io Connection to 192.168.178.127 from 192.168.178.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 9 May 26 08:51:53 volumio2 sudo[2300]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 08:51:53 volumio2 sudo[2300]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:51:53 volumio2 sudo[2300]: pam_unix(sudo:session): session closed for user root May 26 08:51:53 volumio2 sudo[2302]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 08:51:53 volumio2 sudo[2302]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:51:53 volumio2 sudo[2302]: pam_unix(sudo:session): session closed for user root May 26 08:51:53 volumio2 volumio[1040]: verbose: New Socket.io Connection to 192.168.178.127 from 192.168.178.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 9 May 26 08:51:53 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:51:53 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 26 08:51:53 volumio2 volumio[1040]: info: Listing playlists May 26 08:51:53 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 26 08:51:53 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 08:51:53 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 08:51:53 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 08:51:55 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetVisibleSources May 26 08:51:55 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 08:51:55 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetQueue May 26 08:51:55 volumio2 volumio[1040]: info: CoreStateMachine::getQueue May 26 08:51:55 volumio2 volumio[1040]: info: CorePlayQueue::getQueue May 26 08:51:55 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 08:51:55 volumio2 volumio[1040]: info: Received Get System Info May 26 08:51:55 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 08:51:55 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 08:51:55 volumio2 volumio[1040]: info: Discovery: Getting this device information May 26 08:51:55 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:51:55 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 08:51:56 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 08:51:56 volumio2 volumio[1040]: info: Received Get System Info May 26 08:51:56 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 08:51:56 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 08:51:56 volumio2 volumio[1040]: info: Discovery: Getting this device information May 26 08:51:56 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:51:56 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 08:51:58 volumio2 sudo[2321]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 08:51:58 volumio2 sudo[2321]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:51:58 volumio2 sudo[2321]: pam_unix(sudo:session): session closed for user root May 26 08:51:58 volumio2 sudo[2323]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 08:51:58 volumio2 sudo[2323]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:51:58 volumio2 sudo[2323]: pam_unix(sudo:session): session closed for user root May 26 08:51:58 volumio2 volumio[1040]: verbose: New Socket.io Connection to 192.168.178.127 from 192.168.178.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 9 May 26 08:51:58 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetVisibleSources May 26 08:51:58 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 08:51:58 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:51:58 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetQueue May 26 08:51:58 volumio2 volumio[1040]: info: CoreStateMachine::getQueue May 26 08:51:58 volumio2 volumio[1040]: info: CorePlayQueue::getQueue May 26 08:51:58 volumio2 volumio[1040]: info: Listing playlists May 26 08:51:58 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 26 08:51:58 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 08:51:58 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 08:51:58 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 08:52:00 volumio2 volumio[1040]: info: Received Get System Info May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 08:52:00 volumio2 volumio[1040]: info: Discovery: Getting this device information May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 08:52:00 volumio2 volumio[1040]: info: Received Get System Info May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 08:52:00 volumio2 volumio[1040]: info: Discovery: Getting this device information May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:52:00 volumio2 volumio[1040]: info: Retrieving Cloud Streaming UI May 26 08:52:00 volumio2 volumio[1040]: info: Getting Tidal Cloud Configuration May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:52:00 volumio2 volumio[1040]: info: Getting Qobuz Cloud Configuration May 26 08:52:00 volumio2 volumio[1040]: info: Asking plugin for UI Config May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:52:00 volumio2 volumio[1040]: info: Getting Spotify Cloud Configuration May 26 08:52:00 volumio2 volumio[1040]: info: Asking plugin for UI Config May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:52:00 volumio2 volumio[1040]: info: Saving Spotify Acccount May 26 08:52:00 volumio2 volumio[1040]: info: Got Tidal Cloud Configuration May 26 08:52:00 volumio2 volumio[1040]: info: Got it May 26 08:52:00 volumio2 volumio[1040]: info: Got it May 26 08:52:00 volumio2 volumio[1040]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:52:00 volumio2 volumio[1040]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetBrowseSources May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetBrowseSources May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetBrowseSources May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 08:52:00 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 26 08:52:04 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 08:52:08 volumio2 ntpd[890]: CLOCK: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 26 08:52:08 volumio2 ntpd[890]: CLOCK: time stepped by 0.467515 May 26 08:52:08 volumio2 ntpd[890]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes May 26 08:52:08 volumio2 ntpd[890]: CLOCK: frequency error 1543 PPM exceeds tolerance 500 PPM May 26 08:52:08 volumio2 systemd[1]: Starting fstrim.service - Discard unused blocks on filesystems from /etc/fstab... May 26 08:52:08 volumio2 systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 26 08:52:08 volumio2 dbus-daemon[670]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.29' (uid=0 pid=2343 comm="timedatectl show --property=NTPSynchronized --valu") May 26 08:52:08 volumio2 systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 26 08:52:08 volumio2 systemd[1]: fstrim.service: Deactivated successfully. May 26 08:52:08 volumio2 systemd[1]: Finished fstrim.service - Discard unused blocks on filesystems from /etc/fstab. May 26 08:52:08 volumio2 dbus-daemon[670]: [system] Successfully activated service 'org.freedesktop.timedate1' May 26 08:52:08 volumio2 systemd[1]: Started systemd-timedated.service - Time & Date Service. May 26 08:52:08 volumio2 setdatetime-helper.sh[2341]: Time is not synchronized. Attempting to sync... May 26 08:52:08 volumio2 sudo[2353]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Mon, 26 May 2025 07:52:08 GMT#015' May 26 08:52:08 volumio2 sudo[2353]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 26 08:52:08 volumio2 setdatetime-helper.sh[2354]: Mon May 26 08:52:08 +01 2025 May 26 08:52:08 volumio2 setdatetime-helper.sh[2341]: Time synchronized successfully. May 26 08:52:08 volumio2 systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 26 08:52:08 volumio2 sudo[2353]: pam_unix(sudo:session): session closed for user root May 26 08:52:08 volumio2 systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 26 08:52:08 volumio2 systemd-journald[337]: Time jumped backwards, rotating. May 26 08:52:08 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 08:52:12 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 08:52:15 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 08:52:15 volumio2 volumio[1040]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 26 08:52:15 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 26 08:52:15 volumio2 volumio[1040]: info: Received Get System Version May 26 08:52:15 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 08:52:15 volumio2 volumio[1040]: info: Received Get System Info May 26 08:52:15 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 08:52:15 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 08:52:15 volumio2 volumio[1040]: info: Discovery: Getting this device information May 26 08:52:15 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:52:15 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 08:52:16 volumio2 volumio[1040]: info: CALLMETHOD: miscellanea my_music updateMusicLibraryBrowseSourcesVisibility [object Object] May 26 08:52:16 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , updateMusicLibraryBrowseSourcesVisibility May 26 08:52:16 volumio2 volumio[1040]: info: CoreCommandRouter::volumioUpdateToBrowseSources May 26 08:52:16 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 08:52:16 volumio2 volumio[1040]: Cannot find translation for source YouTube2 May 26 08:52:16 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 08:52:20 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 26 08:52:22 volumio2 sudo[2373]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 08:52:22 volumio2 sudo[2373]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:52:22 volumio2 sudo[2373]: pam_unix(sudo:session): session closed for user root May 26 08:52:22 volumio2 sudo[2375]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 08:52:22 volumio2 sudo[2375]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:52:22 volumio2 sudo[2375]: pam_unix(sudo:session): session closed for user root May 26 08:52:22 volumio2 volumio[1040]: verbose: New Socket.io Connection to 192.168.178.127 from 192.168.178.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 9 May 26 08:52:23 volumio2 sudo[2379]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 08:52:23 volumio2 sudo[2379]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:52:23 volumio2 sudo[2379]: pam_unix(sudo:session): session closed for user root May 26 08:52:23 volumio2 sudo[2381]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 08:52:23 volumio2 sudo[2381]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:52:23 volumio2 sudo[2381]: pam_unix(sudo:session): session closed for user root May 26 08:52:23 volumio2 volumio[1040]: verbose: New Socket.io Connection to 192.168.178.127 from 192.168.178.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 9 May 26 08:52:23 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:52:23 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 26 08:52:23 volumio2 volumio[1040]: info: Listing playlists May 26 08:52:23 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 26 08:52:23 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 08:52:23 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 08:52:23 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 08:52:24 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetVisibleSources May 26 08:52:24 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 08:52:24 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetQueue May 26 08:52:24 volumio2 volumio[1040]: info: CoreStateMachine::getQueue May 26 08:52:24 volumio2 volumio[1040]: info: CorePlayQueue::getQueue May 26 08:52:25 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 08:52:25 volumio2 volumio[1040]: info: Received Get System Info May 26 08:52:25 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 08:52:25 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 08:52:25 volumio2 volumio[1040]: info: Discovery: Getting this device information May 26 08:52:25 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:52:25 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 08:52:25 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 08:52:25 volumio2 volumio[1040]: info: Received Get System Info May 26 08:52:25 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 08:52:25 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 08:52:25 volumio2 volumio[1040]: info: Discovery: Getting this device information May 26 08:52:25 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:52:25 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 08:52:31 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:52:34 volumio2 volumio[1040]: info: CoreCommandRouter::getUIConfigOnPlugin May 26 08:52:34 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 26 08:52:35 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 26 08:52:35 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 26 08:52:35 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs May 26 08:52:35 volumio2 volumio[1040]: info: Received Get System Version May 26 08:52:35 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 08:52:35 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds May 26 08:52:37 volumio2 systemd[1]: systemd-timedated.service: Deactivated successfully. May 26 08:52:41 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 08:52:41 volumio2 volumio[1040]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 26 08:52:41 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 26 08:52:41 volumio2 volumio[1040]: info: Received Get System Version May 26 08:52:41 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 26 08:52:41 volumio2 volumio[1040]: info: Received Get System Info May 26 08:52:41 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 08:52:41 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 08:52:41 volumio2 volumio[1040]: info: Discovery: Getting this device information May 26 08:52:41 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:52:41 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 08:52:45 volumio2 sudo[2463]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 08:52:45 volumio2 sudo[2463]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:52:45 volumio2 sudo[2463]: pam_unix(sudo:session): session closed for user root May 26 08:52:45 volumio2 sudo[2465]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 08:52:45 volumio2 sudo[2465]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:52:45 volumio2 sudo[2465]: pam_unix(sudo:session): session closed for user root May 26 08:52:45 volumio2 volumio[1040]: verbose: New Socket.io Connection to 192.168.178.127 from 192.168.178.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 9 May 26 08:52:45 volumio2 sudo[2469]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 26 08:52:45 volumio2 sudo[2469]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:52:45 volumio2 sudo[2469]: pam_unix(sudo:session): session closed for user root May 26 08:52:45 volumio2 sudo[2471]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 26 08:52:45 volumio2 sudo[2471]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 26 08:52:45 volumio2 sudo[2471]: pam_unix(sudo:session): session closed for user root May 26 08:52:45 volumio2 volumio[1040]: verbose: New Socket.io Connection to 192.168.178.127 from 192.168.178.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 9 May 26 08:52:45 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:52:45 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 26 08:52:45 volumio2 volumio[1040]: info: Listing playlists May 26 08:52:45 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 26 08:52:45 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 26 08:52:45 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 26 08:52:45 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 26 08:52:46 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetVisibleSources May 26 08:52:46 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 26 08:52:46 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetQueue May 26 08:52:46 volumio2 volumio[1040]: info: CoreStateMachine::getQueue May 26 08:52:46 volumio2 volumio[1040]: info: CorePlayQueue::getQueue May 26 08:52:47 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 08:52:47 volumio2 volumio[1040]: info: Received Get System Info May 26 08:52:47 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 08:52:47 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 08:52:47 volumio2 volumio[1040]: info: Discovery: Getting this device information May 26 08:52:47 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:52:47 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 08:52:48 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 26 08:52:48 volumio2 volumio[1040]: info: Received Get System Info May 26 08:52:48 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 26 08:52:48 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 26 08:52:48 volumio2 volumio[1040]: info: Discovery: Getting this device information May 26 08:52:48 volumio2 volumio[1040]: info: CoreCommandRouter::volumioGetState May 26 08:52:48 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 26 08:52:48 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 26 08:52:48 volumio2 volumio[1040]: info: Preload queue cleared May 26 08:52:51 volumio2 volumio[1040]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 26 08:52:51 volumio2 volumio[1040]: info: READ May 26 08:52:51 volumio2 volumio[1040]: Use XMLElement.setAttribute instead May 26 08:52:51 volumio2 volumio[1040]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 08:52:51 volumio2 volumio[1040]: TypeError: children[i].attr(...).value is not a function May 26 08:52:51 volumio2 volumio[1040]: at /volumio/app/plugins/music_service/webradio/index.js:286:47 May 26 08:52:51 volumio2 volumio[1040]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) May 26 08:52:51 volumio2 volumio[1040]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 08:52:52 volumio2 sudo[2488]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-26 08:51' May 26 08:52:52 volumio2 sudo[2488]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="fd567ba9bc0dc34c0403e2d5b72a0f46467d1983" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri May 23 08:02:06 UTC 2025" VOLUMIO_VERSION="0.069" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="76fa67e30b28261e1dc7c3a89e610b9e"