Mar 14 16:59:00 wyse-bw volumio[1323]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 14 16:59:00 wyse-bw volumio[1323]: info: ___________ START PLUGINS ___________ Mar 14 16:59:00 wyse-bw volumio[1323]: info: ControllerMpd::onStart: Initializing MPD Mar 14 16:59:00 wyse-bw volumio[1323]: info: Creating MPD Configuration file Mar 14 16:59:00 wyse-bw systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 14 16:59:00 wyse-bw volumio[1323]: info: [1741967940029] CoreMusicLibrary::Adding element Media Servers Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 16:59:00 wyse-bw sudo[1606]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 14 16:59:00 wyse-bw sudo[1606]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:00 wyse-bw systemd[1]: Starting mpd.service - Music Player Daemon... Mar 14 16:59:00 wyse-bw sudo[1606]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:00 wyse-bw sudo[1609]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 14 16:59:00 wyse-bw sudo[1609]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:00 wyse-bw systemd[1]: mpd.service: Deactivated successfully. Mar 14 16:59:00 wyse-bw systemd[1]: Stopped mpd.service - Music Player Daemon. Mar 14 16:59:00 wyse-bw systemd[1]: mpd.socket: Deactivated successfully. Mar 14 16:59:00 wyse-bw systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Mar 14 16:59:00 wyse-bw systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Mar 14 16:59:00 wyse-bw systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 14 16:59:00 wyse-bw systemd[1]: Starting mpd.service - Music Player Daemon... Mar 14 16:59:00 wyse-bw volumio[1323]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 14 16:59:00 wyse-bw volumio[1323]: info: [1741967940132] CoreMusicLibrary::Adding element Last_100 Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 14 16:59:00 wyse-bw volumio[1323]: info: [1741967940138] CoreMusicLibrary::Adding element Webradio Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 16:59:00 wyse-bw volumio[1323]: info: Initializing BBC Radios Mar 14 16:59:00 wyse-bw sudo[1616]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 14 16:59:00 wyse-bw sudo[1616]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 14 16:59:00 wyse-bw sudo[1629]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 14 16:59:00 wyse-bw sudo[1616]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: Creating Spotify config file Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 14 16:59:00 wyse-bw volumio[1323]: info: [1741967940412] CoreMusicLibrary::Adding element Randomizer Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 16:59:00 wyse-bw volumio[1323]: Cannot find translation for source Randomizer Mar 14 16:59:00 wyse-bw volumio[1323]: info: Volumio Calling Home Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: adding 9d52085f-0190-4abf-b426-b522feb31676 Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: Found device Wyse-BW Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:00 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:00 wyse-bw volumio[1323]: verbose: New Socket.io Connection to 192.168.1.253:3000 from 192.168.1.96 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Mar 14 16:59:00 wyse-bw volumio[1323]: info: VolumeController:: Volume=48 Mute =false Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreStateMachine::pushState Mar 14 16:59:00 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioPushState Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: this is already registered, 9d52085f-0190-4abf-b426-b522feb31676 Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: Found device Wyse-BW Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:00 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:00 wyse-bw volumio[1323]: verbose: New Socket.io Connection to 192.168.1.253 from 192.168.1.86 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Mar 14 16:59:00 wyse-bw volumio[1323]: verbose: New Socket.io Connection to 192.168.1.253:3000 from 192.168.1.15 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Mar 14 16:59:00 wyse-bw volumio[1323]: info: MPD Permissions set Mar 14 16:59:00 wyse-bw volumio[1323]: info: MPD Permissions set Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:00 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 14 16:59:00 wyse-bw volumio[1323]: info: Volumio called home Mar 14 16:59:00 wyse-bw volumio[1323]: info: Spotify config file written Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: adding d6026ebd-3a3d-482c-ac7d-054a97232f49 Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: Found device Primo Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: Connecting to remote: 192.168.1.96 Mar 14 16:59:00 wyse-bw sudo[1642]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Mar 14 16:59:00 wyse-bw sudo[1642]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:00 wyse-bw systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Mar 14 16:59:00 wyse-bw systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 14 16:59:00 wyse-bw systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 14 16:59:00 wyse-bw go-librespot[1646]: Librespot-go daemon starting... Mar 14 16:59:00 wyse-bw sudo[1642]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 14 16:59:00 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:00 wyse-bw volumio[1323]: info: No need to fix Spotify hosts Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: adding 46637c89-32a4-4ae4-a5c1-09caf2e7469d Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: Found device Primo-Marco Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: Connecting to remote: 192.168.1.155 Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: adding 25134f3b-c06d-498a-9ee6-ffd5140fb3dd Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: Found device Volumio-N2 Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: Connecting to remote: 192.168.1.97 Mar 14 16:59:00 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:00+01:00" level=info msg="generated new device id: 5f668652f9233a00b24b541391852ec587292ef3" Mar 14 16:59:00 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:00+01:00" level=debug msg="stored credentials found for z4ujt0w8jsm3yt93kz6hrseoy" Mar 14 16:59:00 wyse-bw volumio[1323]: info: Discovery: Connected to remote: 192.168.1.96 Mar 14 16:59:00 wyse-bw volumio[1323]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Mar 14 16:59:00 wyse-bw volumio[1323]: SPOTIFY: BQBSsHaRTMz25YtKreZIlQH6TAsW2_qHfwAU_kk_deTWa-F7GiIKIohppUVtbgtB1H7RRsnWvs859fQTCHs8rHdy6blubVcvgc3da41MWN_7-nzDu9UJlVRZQ77GyG1wN0QMYvjRKeqxKOo1ShPd42lo_A2L7AlvDVSBcS2FBZXAEC5tpPpUENVxy81X92VuaunaG96Y7N68XGYKzXQLHsIBGI1lN-jsXLyotHL9_8fSwX97NV5bbzgd1pNbJaTJyXkz5kNurAcesJVuA9-w5BEfgEInsCfkAATecVI Mar 14 16:59:00 wyse-bw volumio[1323]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Mar 14 16:59:00 wyse-bw volumio[1323]: info: New Spotify access token = BQBSsHaRTMz25YtKreZIlQH6TAsW2_qHfwAU_kk_deTWa-F7GiIKIohppUVtbgtB1H7RRsnWvs859fQTCHs8rHdy6blubVcvgc3da41MWN_7-nzDu9UJlVRZQ77GyG1wN0QMYvjRKeqxKOo1ShPd42lo_A2L7AlvDVSBcS2FBZXAEC5tpPpUENVxy81X92VuaunaG96Y7N68XGYKzXQLHsIBGI1lN-jsXLyotHL9_8fSwX97NV5bbzgd1pNbJaTJyXkz5kNurAcesJVuA9-w5BEfgEInsCfkAATecVI Mar 14 16:59:00 wyse-bw volumio[1323]: info: Spotify credentials grant success - running version from March 24, 2019 Mar 14 16:59:01 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Mar 14 16:59:01 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:01 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:01 wyse-bw volumio[1323]: verbose: New Socket.io Connection to 192.168.1.253 from 192.168.1.86 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Mar 14 16:59:01 wyse-bw systemd[1]: systemd-fsckd.service: Deactivated successfully. Mar 14 16:59:01 wyse-bw volumio[1323]: info: Discovery: Connected to remote: 192.168.1.155 Mar 14 16:59:01 wyse-bw volumio[1323]: info: Discovery: Connected to remote: 192.168.1.97 Mar 14 16:59:01 wyse-bw volumio[1323]: info: Starting Shairport Sync Mar 14 16:59:01 wyse-bw volumio[1323]: info: Starting Shairport Sync Mar 14 16:59:01 wyse-bw volumio[1323]: info: Starting Shairport Sync Mar 14 16:59:01 wyse-bw sudo[1668]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 14 16:59:01 wyse-bw sudo[1671]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 14 16:59:01 wyse-bw sudo[1668]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:01 wyse-bw sudo[1671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:01 wyse-bw volumio[1323]: verbose: New Socket.io Connection to 192.168.1.253 from 192.168.1.86 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Mar 14 16:59:01 wyse-bw sudo[1673]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 14 16:59:01 wyse-bw sudo[1673]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:01 wyse-bw systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 14 16:59:01 wyse-bw systemd[1]: shairport-sync.service: Deactivated successfully. Mar 14 16:59:01 wyse-bw systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 14 16:59:01 wyse-bw systemd[1]: shairport-sync.service: Consumed 1.996s CPU time. Mar 14 16:59:01 wyse-bw systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 14 16:59:01 wyse-bw sudo[1671]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:01 wyse-bw sudo[1668]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:01 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:01+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Mar 14 16:59:01 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:01+01:00" 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]" Mar 14 16:59:01 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:01+01:00" 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]" Mar 14 16:59:01 wyse-bw systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 14 16:59:01 wyse-bw systemd[1]: shairport-sync.service: Deactivated successfully. Mar 14 16:59:01 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:01+01:00" level=debug msg="zeroconf server listening on port 33119" Mar 14 16:59:01 wyse-bw systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 14 16:59:01 wyse-bw systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 14 16:59:01 wyse-bw sudo[1673]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:01 wyse-bw volumio[1323]: info: Shairport-Sync Started Mar 14 16:59:01 wyse-bw volumio[1323]: Error adding Membership: Error: addMembership EINVAL Mar 14 16:59:01 wyse-bw volumio[1323]: info: Shairport-Sync Started Mar 14 16:59:01 wyse-bw volumio[1323]: info: Shairport-Sync Started Mar 14 16:59:01 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Mar 14 16:59:01 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Mar 14 16:59:01 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:01+01:00" level=debug msg="obtained new client token: AAClTKyFQQyns9QveBdVQGCZ0FN28/RHcuJqWZmZJxGIN+end+mdS/y3AKlEnfJJ41xmlkQmeRokHTRFas0K7czXuOqyUhF6eQQGn/K3SpJ6Y3+RvMm6hTt7R+hU95britrGVYUoQFOHF4UFwtvVScLejbn8xHWFNxqXYHBnoEEegmQ5y/kEZSPiYGQWXzsFYWigkBHrfZQiyp4/Ik/hVtKIkp0VBtl38YYec6rv2BfMkVSrbIifutZIB8b6wTg=" Mar 14 16:59:01 wyse-bw volumio[1323]: SPOTIFY: User informations: {"country":"NL","display_name":"Marco","email":"m.botermans@home.nl","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/z4ujt0w8jsm3yt93kz6hrseoy"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/z4ujt0w8jsm3yt93kz6hrseoy","id":"z4ujt0w8jsm3yt93kz6hrseoy","images":[],"product":"premium","type":"user","uri":"spotify:user:z4ujt0w8jsm3yt93kz6hrseoy"} Mar 14 16:59:01 wyse-bw volumio[1323]: info: Spotify Successfully logged in Mar 14 16:59:01 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 14 16:59:01 wyse-bw volumio[1323]: info: [1741967941449] CoreMusicLibrary::Adding element Spotify Mar 14 16:59:01 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 16:59:01 wyse-bw volumio[1323]: Cannot find translation for source Randomizer Mar 14 16:59:01 wyse-bw volumio[1323]: Cannot find translation for source Spotify Mar 14 16:59:01 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:01+01:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070 (error: dial tcp 34.158.1.133:4070: connect: connection refused), retrying with a different AP" Mar 14 16:59:01 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Mar 14 16:59:01 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:01+01:00" level=info msg="connected to ap-gew4.spotify.com:443" Mar 14 16:59:01 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:01 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:01 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:01+01:00" level=debug msg="completed keyexchange" Mar 14 16:59:01 wyse-bw sudo[1696]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 14 16:59:01 wyse-bw sudo[1696]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:01 wyse-bw sudo[1696]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:01 wyse-bw sudo[1698]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 14 16:59:01 wyse-bw sudo[1698]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:01 wyse-bw sudo[1698]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:01 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Mar 14 16:59:01 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:01 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:01 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:01 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="completed challenge" Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="authenticated as z4ujt0w8jsm3yt93kz6hrseoy" Mar 14 16:59:02 wyse-bw volumio[1323]: verbose: New Socket.io Connection to 192.168.1.253 from 192.168.1.86 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="authenticated as z4ujt0w8jsm3yt93kz6hrseoy" Mar 14 16:59:02 wyse-bw mpd[1635]: Mar 14 16:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="dealer connection opened" Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="initializing zeroconf session, username: z4ujt0w8jsm3yt93kz6hrseoy" Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="autoplay enabled: false" Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="received connection id: YjQ1NGIwZjktMDgyZS00NmZlLTgyMjctMzBkMjRjZmRmYTEyK2RlYWxlcit0Y3A6Ly8wYWNhNTg0OS5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArNkI3MEFGMzRGQzAzRTg1NTczM0VDRTVERjJENUIyNTE3QTUxMDA1REM0QzlDQUY5Q0Y1NjU0RTM1NEVBMzNGNg==" Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetVisibleSources Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:02 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 14 16:59:02 wyse-bw volumio[1323]: info: Received Get System Info Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 16:59:02 wyse-bw volumio[1323]: info: Discovery: Getting this device information Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:02 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:02 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:02 wyse-bw volumio[1323]: info: Listing playlists Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 14 16:59:02 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 14 16:59:02 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:02+01:00" level=debug msg="put connect state because NEW_DEVICE" Mar 14 16:59:02 wyse-bw dhcpcd[748]: timed out Mar 14 16:59:02 wyse-bw sh[722]: timed out Mar 14 16:59:02 wyse-bw sh[598]: ifup: failed to bring up eth0 Mar 14 16:59:02 wyse-bw systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Mar 14 16:59:02 wyse-bw systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Mar 14 16:59:03 wyse-bw systemd[1]: Started mpd.service - Music Player Daemon. Mar 14 16:59:03 wyse-bw sudo[1598]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:03 wyse-bw sudo[1609]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:03 wyse-bw volumio[1323]: info: Completed starting Core Plugins Mar 14 16:59:03 wyse-bw volumio[1323]: info: ------------------------------------------- Mar 14 16:59:03 wyse-bw volumio[1323]: info: ----- MyVolumio plugins startup ---- Mar 14 16:59:03 wyse-bw volumio[1323]: info: ------------------------------------------- Mar 14 16:59:03 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 14 16:59:03 wyse-bw volumio[1323]: error: MPD error: The expression evaluated to a falsy value: Mar 14 16:59:03 wyse-bw volumio[1323]: assert.ok(self.idling) Mar 14 16:59:03 wyse-bw volumio[1323]: error: The expression evaluated to a falsy value: Mar 14 16:59:03 wyse-bw volumio[1323]: assert.ok(self.idling) Mar 14 16:59:03 wyse-bw volumio[1323]: info: MPD running with PID1635 Mar 14 16:59:03 wyse-bw volumio[1323]: ,establishing connection Mar 14 16:59:03 wyse-bw volumio[1323]: error: updateQueue error: null Mar 14 16:59:03 wyse-bw volumio[1323]: error: updateQueue error: null Mar 14 16:59:03 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 16:59:03 wyse-bw volumio[1323]: info: Received Get System Info Mar 14 16:59:03 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 16:59:03 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 16:59:03 wyse-bw volumio[1323]: info: Discovery: Getting this device information Mar 14 16:59:03 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:03 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:03 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 16:59:03 wyse-bw volumio[1323]: info: go-librespot daemon successfully initialized Mar 14 16:59:04 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 14 16:59:04 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 14 16:59:04 wyse-bw sudo[1723]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 14 16:59:04 wyse-bw sudo[1723]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:04 wyse-bw sudo[1723]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:04 wyse-bw sudo[1725]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 14 16:59:04 wyse-bw sudo[1725]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:04 wyse-bw sudo[1725]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:04 wyse-bw sudo[1729]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 14 16:59:04 wyse-bw sudo[1729]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:04 wyse-bw systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 14 16:59:04 wyse-bw sudo[1729]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:04 wyse-bw volumio[1323]: info: Upmpdcli Daemon Started Mar 14 16:59:05 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 16:59:05 wyse-bw volumio[1323]: info: Received Get System Info Mar 14 16:59:05 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 16:59:05 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 16:59:05 wyse-bw volumio[1323]: info: Discovery: Getting this device information Mar 14 16:59:05 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:05 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:05 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 16:59:05 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 14 16:59:06 wyse-bw volumio[1323]: info: Initializing connection to go-librespot Websocket Mar 14 16:59:06 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:06+01:00" level=debug msg="new websocket client" Mar 14 16:59:06 wyse-bw volumio[1323]: info: Connection to go-librespot Websocket established Mar 14 16:59:09 wyse-bw volumio[1323]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 14 16:59:10 wyse-bw volumio[1323]: info: Getting Spotify volume Mar 14 16:59:10 wyse-bw volumio[1323]: info: Spotify volume: 100 Mar 14 16:59:10 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Mar 14 16:59:10 wyse-bw upmpdcli[1748]: writing RSA key Mar 14 16:59:12 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 14 16:59:14 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:14 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:15 wyse-bw volumio[1323]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Mar 14 16:59:15 wyse-bw volumio[1323]: SPOTIFY: SPOTIFY VOLUME 100 Mar 14 16:59:15 wyse-bw volumio[1323]: SPOTIFY: VOLUMIO VOLUME 48 Mar 14 16:59:15 wyse-bw volumio[1323]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 14 16:59:15 wyse-bw volumio[1323]: info: Setting Spotify Volume from Volumio: 48 Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 14 16:59:16 wyse-bw volumio[1323]: info: Adding plugin bluetooth to MyMusic Plugins Mar 14 16:59:16 wyse-bw volumio[1323]: info: Adding plugin multiroom to MyMusic Plugins Mar 14 16:59:16 wyse-bw volumio[1323]: info: Adding plugin metavolumio to MyMusic Plugins Mar 14 16:59:16 wyse-bw volumio[1323]: info: Adding plugin cd_controller to MyMusic Plugins Mar 14 16:59:16 wyse-bw volumio[1323]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 14 16:59:16 wyse-bw volumio[1323]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 14 16:59:16 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 14 16:59:17 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 14 16:59:17 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 14 16:59:17 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:17 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:17 wyse-bw volumio[1323]: info: Starting MyVolumio Remote Streaming Endpoints Mar 14 16:59:17 wyse-bw volumio[1323]: info: MyVolumio login type: Token Mar 14 16:59:17 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 14 16:59:17 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 14 16:59:18 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 14 16:59:18 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 14 16:59:18 wyse-bw volumio[1323]: info: Streaming services startup Mar 14 16:59:18 wyse-bw volumio[1323]: info: Starting Streaming Daemon Mar 14 16:59:18 wyse-bw sudo[1767]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 14 16:59:18 wyse-bw sudo[1767]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:18 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 14 16:59:18 wyse-bw sudo[1767]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:18 wyse-bw volumio[1323]: SPOTIFY: SETTING SPOTIFY VOLUME 48 Mar 14 16:59:18 wyse-bw volumio[1323]: info: Sending Spotify command with payload to local API: /player/volume Mar 14 16:59:19 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 16:59:19 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:19+01:00" level=debug msg="update volume to 31456/65535" Mar 14 16:59:19 wyse-bw volumio[1323]: error: Cannot start Volumio Streaming Daemon Mar 14 16:59:19 wyse-bw volumio[1323]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 14 16:59:19 wyse-bw volumio[1323]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 14 16:59:19 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:19+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Mar 14 16:59:19 wyse-bw go-librespot[1653]: time="2025-03-14T16:59:19+01:00" level=trace msg="emitting websocket event: volume" Mar 14 16:59:21 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 16:59:21 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 16:59:21 wyse-bw volumio[1323]: info: Discovery: Getting this device information Mar 14 16:59:21 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:21 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:21 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 16:59:21 wyse-bw volumio[1323]: SPOTIFY: received: {"type":"volume","data":{"value":48,"max":100}} Mar 14 16:59:21 wyse-bw volumio[1323]: SPOTIFY: RECEIVED SPOTIFY VOLUME 48 Mar 14 16:59:21 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 14 16:59:21 wyse-bw volumio[1323]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 14 16:59:21 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 14 16:59:21 wyse-bw volumio[1323]: info: Received Get System Version Mar 14 16:59:21 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 16:59:21 wyse-bw volumio[1323]: info: Received Get System Info Mar 14 16:59:21 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 16:59:21 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 16:59:21 wyse-bw volumio[1323]: info: Discovery: Getting this device information Mar 14 16:59:21 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:21 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:21 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 16:59:21 wyse-bw volumio[1323]: info: Enabling plugin fusiondsp Mar 14 16:59:21 wyse-bw volumio[1323]: info: Loading plugin "fusiondsp"... Mar 14 16:59:21 wyse-bw volumio[1323]: info: Preparing to generate the ALSA configuration file Mar 14 16:59:22 wyse-bw volumio[1323]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 14 16:59:22 wyse-bw volumio[1323]: info: Reading ALSA contributions from plugins. Mar 14 16:59:25 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 16:59:28 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 16:59:29 wyse-bw volumio[1323]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//EQ3' Mar 14 16:59:30 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 16:59:31 wyse-bw volumio[1323]: (node:1323) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 close listeners added to [TLSSocket]. Use emitter.setMaxListeners() to increase limit Mar 14 16:59:31 wyse-bw volumio[1323]: (Use `node --trace-warnings ...` to show where the warning was created) Mar 14 16:59:31 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 16:59:31 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:31 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 14 16:59:32 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 16:59:33 wyse-bw volumio[1323]: info: Asound.conf file written Mar 14 16:59:33 wyse-bw sudo[1794]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 14 16:59:33 wyse-bw sudo[1794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:33 wyse-bw sudo[1794]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:33 wyse-bw volumio[1323]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Mar 14 16:59:33 wyse-bw volumio[1323]: info: Output device has changed, restarting MPD Mar 14 16:59:33 wyse-bw volumio[1323]: info: Output device has changed, restarting Shairport Sync Mar 14 16:59:33 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:33 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:33 wyse-bw sudo[1801]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 14 16:59:33 wyse-bw sudo[1801]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:33 wyse-bw sudo[1801]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:33 wyse-bw sudo[1803]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 14 16:59:33 wyse-bw sudo[1803]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:34 wyse-bw volumio[1323]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 14 16:59:34 wyse-bw volumio[1323]: info: PLUGIN START: fusiondsp Mar 14 16:59:34 wyse-bw systemd[1]: Stopping mpd.service - Music Player Daemon... Mar 14 16:59:34 wyse-bw volumio[1323]: info: Loading i18n strings for locale en Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:34 wyse-bw volumio[1323]: info: FusionDsp - mixtype--------------------- Hardware Mar 14 16:59:34 wyse-bw volumio[1323]: info: Preparing to generate the ALSA configuration file Mar 14 16:59:34 wyse-bw volumio[1323]: info: Done. Mar 14 16:59:34 wyse-bw volumio[1323]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 14 16:59:34 wyse-bw volumio[1323]: info: Reading ALSA contributions from plugins. Mar 14 16:59:34 wyse-bw volumio-remote-updater[742]: No test mode Mar 14 16:59:34 wyse-bw volumio-remote-updater[742]: No alpha test mode Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 14 16:59:34 wyse-bw systemd[1]: mpd.service: Deactivated successfully. Mar 14 16:59:34 wyse-bw systemd[1]: Stopped mpd.service - Music Player Daemon. Mar 14 16:59:34 wyse-bw systemd[1]: mpd.service: Consumed 4.482s CPU time. Mar 14 16:59:34 wyse-bw systemd[1]: mpd.socket: Deactivated successfully. Mar 14 16:59:34 wyse-bw systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Mar 14 16:59:34 wyse-bw systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Mar 14 16:59:34 wyse-bw systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 14 16:59:34 wyse-bw systemd[1]: Starting mpd.service - Music Player Daemon... Mar 14 16:59:34 wyse-bw sudo[1811]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 14 16:59:34 wyse-bw sudo[1811]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 14 16:59:34 wyse-bw sudo[1811]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:34 wyse-bw volumio[1323]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//EQ3' Mar 14 16:59:34 wyse-bw volumio[1323]: info: MPD Permissions set Mar 14 16:59:34 wyse-bw volumio[1323]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

 

NEW ADDITIONS

 

","title":"Update v3.795","updateavailable":true} Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 16:59:34 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:34 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:35 wyse-bw volumio[1323]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 14 16:59:35 wyse-bw volumio[1323]: info: Starting Shairport Sync Mar 14 16:59:35 wyse-bw volumio[1323]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//EQ3' Mar 14 16:59:35 wyse-bw sudo[1838]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 14 16:59:35 wyse-bw sudo[1838]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:35 wyse-bw systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 14 16:59:35 wyse-bw systemd[1]: shairport-sync.service: Deactivated successfully. Mar 14 16:59:35 wyse-bw systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 14 16:59:35 wyse-bw systemd[1]: shairport-sync.service: Consumed 2.002s CPU time. Mar 14 16:59:35 wyse-bw systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 14 16:59:35 wyse-bw sudo[1838]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:35 wyse-bw volumio[1323]: info: Asound.conf file unchanged, so no further update is needed Mar 14 16:59:35 wyse-bw volumio[1323]: info: Output device has changed, restarting MPD Mar 14 16:59:35 wyse-bw volumio[1323]: info: Output device has changed, restarting Shairport Sync Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:35 wyse-bw sudo[1857]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 14 16:59:35 wyse-bw sudo[1851]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 14 16:59:35 wyse-bw sudo[1857]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:35 wyse-bw sudo[1851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:35 wyse-bw sudo[1851]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:35 wyse-bw volumio[1323]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 14 16:59:35 wyse-bw systemd[1]: mpd.service: Deactivated successfully. Mar 14 16:59:35 wyse-bw systemd[1]: Stopped mpd.service - Music Player Daemon. Mar 14 16:59:35 wyse-bw systemd[1]: mpd.socket: Deactivated successfully. Mar 14 16:59:35 wyse-bw systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Mar 14 16:59:35 wyse-bw systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Mar 14 16:59:35 wyse-bw systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 14 16:59:35 wyse-bw systemd[1]: Starting mpd.service - Music Player Daemon... Mar 14 16:59:35 wyse-bw volumio[1323]: info: Shairport-Sync Started Mar 14 16:59:35 wyse-bw volumio[1323]: info: MPD Permissions set Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:35 wyse-bw sudo[1865]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 14 16:59:35 wyse-bw sudo[1865]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 14 16:59:35 wyse-bw sudo[1865]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:35 wyse-bw volumio[1323]: info: Starting Shairport Sync Mar 14 16:59:35 wyse-bw sudo[1878]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 14 16:59:35 wyse-bw sudo[1878]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:35 wyse-bw systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 14 16:59:35 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:35 wyse-bw systemd[1]: shairport-sync.service: Deactivated successfully. Mar 14 16:59:35 wyse-bw systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 14 16:59:35 wyse-bw sudo[1883]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 14 16:59:35 wyse-bw sudo[1883]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:35 wyse-bw systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 14 16:59:35 wyse-bw sudo[1883]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:35 wyse-bw sudo[1878]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:35 wyse-bw sudo[1880]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 14 16:59:35 wyse-bw volumio[1323]: info: Shairport-Sync Started Mar 14 16:59:35 wyse-bw sudo[1880]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:35 wyse-bw sudo[1880]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:35 wyse-bw volumio[1323]: verbose: New Socket.io Connection to 192.168.1.253 from 192.168.1.86 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Mar 14 16:59:35 wyse-bw volumio[1323]: info: MyVolumio token set successfully Mar 14 16:59:35 wyse-bw volumio[1323]: info: MYVOLUMIO: Adding device Mar 14 16:59:35 wyse-bw volumio[1323]: info: MYVOLUMIO: Evaluating Server Mar 14 16:59:35 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 14 16:59:36 wyse-bw volumio[1323]: info: camilladsp service started and running in background, instance 1 Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:36 wyse-bw volumio[1323]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 384000 768000 <-AAAAAAAAAAAAA Mar 14 16:59:36 wyse-bw volumio[1323]: info: FusionDsp loaded Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 16:59:36 wyse-bw volumio[1323]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Mar 14 16:59:36 wyse-bw sudo[1932]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 14 16:59:36 wyse-bw sudo[1932]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:36 wyse-bw volumio[1323]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 14 16:59:36 wyse-bw volumio[1323]: info: Adding Signal Path Element [object Object] Mar 14 16:59:36 wyse-bw volumio[1323]: info: Adding fusiondspeq DSP Signal Path Element Mar 14 16:59:36 wyse-bw volumio[1323]: info: FusionDsp - ---- installed callbackRead Mar 14 16:59:36 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 16:59:36 wyse-bw systemd[1]: Started fusiondsp.service - FusionDsp Daemon. Mar 14 16:59:36 wyse-bw volumio[1323]: info: MyVolumio Plan changed: premium Mar 14 16:59:36 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Mar 14 16:59:36 wyse-bw volumio[1323]: info: Removing browser output: myVolumio user plan is not superstar Mar 14 16:59:36 wyse-bw volumio[1323]: info: Removing audio output: Mar 14 16:59:36 wyse-bw volumio[1323]: info: MYVOLUMIO: Adding device Mar 14 16:59:36 wyse-bw volumio[1323]: info: MYVOLUMIO: Evaluating Server Mar 14 16:59:36 wyse-bw sudo[1932]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 14 16:59:36 wyse-bw volumio[1323]: error: FusionDsp - Reload WebSocket error: [object Object] Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetVisibleSources Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:36 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 14 16:59:36 wyse-bw volumio[1323]: info: Received Get System Info Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 16:59:36 wyse-bw volumio[1323]: info: Discovery: Getting this device information Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:36 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:36 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:36 wyse-bw volumio[1323]: info: Listing playlists Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 14 16:59:36 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 14 16:59:36 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 17 Mar 14 16:59:36 wyse-bw volumio[1323]: info: Remote config written successfully Mar 14 16:59:36 wyse-bw volumio[1323]: info: Starting Tunnel 1 Mar 14 16:59:36 wyse-bw volumio[1323]: info: Starting Tunnel Connection Checker Mar 14 16:59:36 wyse-bw volumio[1323]: info: Completed starting MyVolumio Plugin Mar 14 16:59:36 wyse-bw mpd[1876]: Mar 14 16:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 14 16:59:37 wyse-bw volumio[1323]: 0+0 records in Mar 14 16:59:37 wyse-bw volumio[1323]: 0+0 records out Mar 14 16:59:37 wyse-bw volumio[1323]: 0 bytes copied, 0.000141289 s, 0.0 kB/s Mar 14 16:59:37 wyse-bw volumio[1323]: info: MYVolumio Device enabled Mar 14 16:59:37 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Mar 14 16:59:37 wyse-bw volumio[1323]: info: MyVolumio status changed Mar 14 16:59:37 wyse-bw volumio[1323]: info: Streaming services startup Mar 14 16:59:37 wyse-bw volumio[1323]: info: Starting Streaming Daemon Mar 14 16:59:37 wyse-bw sudo[1958]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 14 16:59:37 wyse-bw sudo[1958]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:37 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Mar 14 16:59:37 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Mar 14 16:59:37 wyse-bw sudo[1958]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:37 wyse-bw volumio[1323]: info: [1741967977848] Starting BluetoothController Mar 14 16:59:37 wyse-bw systemd[1]: Started mpd.service - Music Player Daemon. Mar 14 16:59:37 wyse-bw sudo[1857]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:37 wyse-bw sudo[1803]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:37 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Mar 14 16:59:39 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Mar 14 16:59:39 wyse-bw sudo[1964]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Mar 14 16:59:39 wyse-bw sudo[1964]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:39 wyse-bw sudo[1964]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:39 wyse-bw volumio[1323]: info: MRS: MultiRoom plugin initialized Mar 14 16:59:39 wyse-bw volumio[1323]: info: MRS: STOPPING SNAPCLIENT Mar 14 16:59:39 wyse-bw volumio[1323]: info: MRS: Snap server stop Mar 14 16:59:39 wyse-bw volumio[1323]: info: MRS: STOPPING volumioStreaming Mar 14 16:59:39 wyse-bw sudo[1981]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Mar 14 16:59:39 wyse-bw sudo[1981]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:39 wyse-bw sudo[1983]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Mar 14 16:59:39 wyse-bw sudo[1983]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:39 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Mar 14 16:59:39 wyse-bw sudo[1989]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 14 16:59:39 wyse-bw sudo[1989]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:39 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Mar 14 16:59:39 wyse-bw sudo[1989]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:39 wyse-bw sudo[1985]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Mar 14 16:59:39 wyse-bw sudo[1985]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:39 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Mar 14 16:59:39 wyse-bw sudo[1983]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:39 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Mar 14 16:59:39 wyse-bw sudo[1981]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:39 wyse-bw sudo[1985]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:39 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Mar 14 16:59:39 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Mar 14 16:59:39 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Mar 14 16:59:39 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Mar 14 16:59:39 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Mar 14 16:59:39 wyse-bw volumio[1323]: info: Preparing to generate the ALSA configuration file Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetBrowseSources Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 16:59:39 wyse-bw volumio[1323]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 14 16:59:39 wyse-bw volumio[1323]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 14 16:59:39 wyse-bw volumio[1323]: info: Reading ALSA contributions from plugins. Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 16:59:39 wyse-bw volumio[1323]: info: Received Get System Info Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 16:59:39 wyse-bw volumio[1323]: info: Discovery: Getting this device information Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:39 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 16:59:39 wyse-bw volumio[1323]: info: Received Get System Info Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 16:59:39 wyse-bw volumio[1323]: info: Discovery: Getting this device information Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:39 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 14 16:59:39 wyse-bw volumio[1323]: info: Setting Geolocation for MyVolumio to eu5 Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:39 wyse-bw volumio[1323]: info: MRS: Removed streaming files Mar 14 16:59:39 wyse-bw volumio[1323]: info: MRS: volumioStreaming STOPPED Mar 14 16:59:39 wyse-bw volumio[1323]: info: MRS: SNAPSERVER STOPPED Mar 14 16:59:39 wyse-bw volumio[1323]: info: MRS: SNAPCLIENT STOPPED Mar 14 16:59:39 wyse-bw volumio[1323]: error: Cannot start Volumio Streaming Daemon Mar 14 16:59:39 wyse-bw volumio[1323]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 14 16:59:39 wyse-bw volumio[1323]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 14 16:59:40 wyse-bw volumio[1323]: error: MPD error: The expression evaluated to a falsy value: Mar 14 16:59:40 wyse-bw volumio[1323]: assert.ok(self.idling) Mar 14 16:59:40 wyse-bw volumio[1323]: error: The expression evaluated to a falsy value: Mar 14 16:59:40 wyse-bw volumio[1323]: assert.ok(self.idling) Mar 14 16:59:40 wyse-bw volumio[1323]: info: Successfully Added MyVolumio device Mar 14 16:59:40 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 18 Mar 14 16:59:40 wyse-bw volumio[1323]: error: updateQueue error: null Mar 14 16:59:40 wyse-bw volumio[1323]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//EQ3' Mar 14 16:59:40 wyse-bw volumio[1323]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//EQ3' Mar 14 16:59:40 wyse-bw volumio[1323]: info: Asound.conf file written Mar 14 16:59:40 wyse-bw sudo[1998]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 14 16:59:40 wyse-bw sudo[1998]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:40 wyse-bw sudo[1998]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:41 wyse-bw volumio[1323]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Mar 14 16:59:41 wyse-bw volumio[1323]: info: Output device has changed, restarting MPD Mar 14 16:59:41 wyse-bw volumio[1323]: info: Output device has changed, restarting Shairport Sync Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:41 wyse-bw sudo[2005]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 14 16:59:41 wyse-bw sudo[2005]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:41 wyse-bw sudo[2005]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:41 wyse-bw sudo[2007]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 14 16:59:41 wyse-bw sudo[2007]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:41 wyse-bw volumio[1323]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 14 16:59:41 wyse-bw volumio[1323]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 14 16:59:41 wyse-bw systemd[1]: Stopping mpd.service - Music Player Daemon... Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 14 16:59:41 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Mar 14 16:59:41 wyse-bw volumio[1323]: info: MRS: Pushing multiroomSync output for this device Mar 14 16:59:41 wyse-bw volumio[1323]: info: MRS: Pushing multiroomSync output Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding audio output: Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding audio output: Mar 14 16:59:41 wyse-bw sudo[2017]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/hciconfig hci0 name Wyse-BW Mar 14 16:59:41 wyse-bw sudo[2017]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:41 wyse-bw volumio[1323]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding METAVOLUMIO REST API Endpoints Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Mar 14 16:59:41 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Mar 14 16:59:41 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Mar 14 16:59:41 wyse-bw volumio[1323]: info: Preparing CD Folders Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding CD REST API Endpoints Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Mar 14 16:59:41 wyse-bw volumio[1323]: info: Starting UDEV Watcher for CD Mar 14 16:59:41 wyse-bw volumio[1323]: info: Detecting CD presence with UDEV Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Mar 14 16:59:41 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding inputs REST Endpoints Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Mar 14 16:59:41 wyse-bw volumio[1323]: info: Scanning Audio Inputs Mar 14 16:59:41 wyse-bw systemd[1]: mpd.service: Deactivated successfully. Mar 14 16:59:41 wyse-bw systemd[1]: Stopped mpd.service - Music Player Daemon. Mar 14 16:59:41 wyse-bw systemd[1]: mpd.service: Consumed 2.580s CPU time. Mar 14 16:59:41 wyse-bw systemd[1]: mpd.socket: Deactivated successfully. Mar 14 16:59:41 wyse-bw systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Mar 14 16:59:41 wyse-bw systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Mar 14 16:59:41 wyse-bw systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 14 16:59:41 wyse-bw volumio[1323]: info: Checking against Known Cards name Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 14 16:59:41 wyse-bw volumio[1323]: info: [1741967981393] CoreMusicLibrary::Adding element cht-bsw-rt5672 Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 16:59:41 wyse-bw systemd[1]: Starting mpd.service - Music Player Daemon... Mar 14 16:59:41 wyse-bw volumio[1323]: Cannot find translation for source Randomizer Mar 14 16:59:41 wyse-bw volumio[1323]: Cannot find translation for source Spotify Mar 14 16:59:41 wyse-bw volumio[1323]: Cannot find translation for source cht-bsw-rt5672 Mar 14 16:59:41 wyse-bw volumio[1323]: info: Checking against Known Cards name Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding Server instance for streaming Mar 14 16:59:41 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Mar 14 16:59:41 wyse-bw volumio[1323]: error: Hi Res Audio Failed Login: Missing Login Data Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding HIGHRESAUDIO REST API Endpoints Mar 14 16:59:41 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Mar 14 16:59:41 wyse-bw volumio[1323]: info: Refreshing TIDAL token Mar 14 16:59:41 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Mar 14 16:59:41 wyse-bw volumio[1323]: info: Refreshing QOBUZ token Mar 14 16:59:41 wyse-bw volumio[1323]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Mar 14 16:59:41 wyse-bw sudo[2061]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 14 16:59:41 wyse-bw sudo[2061]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:41 wyse-bw volumio[1323]: info: Updating MyVolumio device info Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:41 wyse-bw sudo[2061]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:41 wyse-bw sudo[2048]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 14 16:59:41 wyse-bw sudo[2048]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 14 16:59:41 wyse-bw sudo[2048]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:41 wyse-bw volumio[1323]: info: MPD Permissions set Mar 14 16:59:41 wyse-bw volumio[1323]: info: Setting Geolocation for MyVolumio to eu3 Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:41 wyse-bw kernel: Bluetooth: Core ver 2.22 Mar 14 16:59:41 wyse-bw kernel: NET: Registered PF_BLUETOOTH protocol family Mar 14 16:59:41 wyse-bw kernel: Bluetooth: HCI device and connection manager initialized Mar 14 16:59:41 wyse-bw kernel: Bluetooth: HCI socket layer initialized Mar 14 16:59:41 wyse-bw kernel: Bluetooth: L2CAP socket layer initialized Mar 14 16:59:41 wyse-bw kernel: Bluetooth: SCO socket layer initialized Mar 14 16:59:41 wyse-bw sudo[2017]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:41 wyse-bw volumio[1323]: info: Access Token successfully retrieved Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 14 16:59:41 wyse-bw volumio[1323]: info: [1741967981769] CoreMusicLibrary::Adding element QOBUZ Mar 14 16:59:41 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 16:59:41 wyse-bw volumio[1323]: Cannot find translation for source Randomizer Mar 14 16:59:41 wyse-bw volumio[1323]: Cannot find translation for source Spotify Mar 14 16:59:41 wyse-bw volumio[1323]: Cannot find translation for source cht-bsw-rt5672 Mar 14 16:59:41 wyse-bw volumio[1323]: Cannot find translation for source QOBUZ Mar 14 16:59:41 wyse-bw volumio[1323]: info: Stopping AccessToken refresher cron for QOBUZ Mar 14 16:59:41 wyse-bw volumio[1323]: info: AccessToken refresher cron started for QOBUZ Mar 14 16:59:41 wyse-bw volumio[1323]: info: Adding QOBUZ REST API Endpoints Mar 14 16:59:41 wyse-bw volumio[1323]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /usr/bin/hciconfig hci0 name 'Wyse-BW' Mar 14 16:59:41 wyse-bw volumio[1323]: Can't get device info: No such device Mar 14 16:59:41 wyse-bw volumio[1323]: info: Starting Shairport Sync Mar 14 16:59:41 wyse-bw sudo[2086]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Mar 14 16:59:41 wyse-bw sudo[2086]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:41 wyse-bw sudo[2088]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 14 16:59:41 wyse-bw volumio[1323]: info: Successfully Updated MyVolumio device Mar 14 16:59:41 wyse-bw sudo[2088]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:41 wyse-bw systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Mar 14 16:59:41 wyse-bw systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Mar 14 16:59:41 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 19 Mar 14 16:59:41 wyse-bw systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Mar 14 16:59:41 wyse-bw sudo[2086]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:41 wyse-bw systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 14 16:59:41 wyse-bw volumio[1323]: info: Remote SSH Started Mar 14 16:59:41 wyse-bw systemd[1]: shairport-sync.service: Deactivated successfully. Mar 14 16:59:41 wyse-bw systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 14 16:59:41 wyse-bw systemd[1]: shairport-sync.service: Consumed 1.609s CPU time. Mar 14 16:59:41 wyse-bw systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 14 16:59:41 wyse-bw sudo[2088]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:41 wyse-bw autossh[2092]: port set to 0, monitoring disabled Mar 14 16:59:41 wyse-bw autossh[2092]: starting ssh (count 1) Mar 14 16:59:41 wyse-bw autossh[2092]: ssh child pid is 2096 Mar 14 16:59:42 wyse-bw volumio[1323]: info: Access Token successfully retrieved Mar 14 16:59:42 wyse-bw volumio[1323]: info: Shairport-Sync Started Mar 14 16:59:42 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 20 Mar 14 16:59:42 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:42 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:42 wyse-bw volumiossh-tunnel[2096]: Warning: Permanently added '[eu5.myvolumio.org]:2222' (RSA) to the list of known hosts. Mar 14 16:59:42 wyse-bw volumio[1323]: info: Successfully Added MyVolumio device Mar 14 16:59:42 wyse-bw mpd[2069]: Mar 14 16:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 14 16:59:42 wyse-bw volumio[1323]: info: Updating MyVolumio device info Mar 14 16:59:42 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:42 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:42 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:42 wyse-bw volumio[1323]: info: Successfully retrieved User Session From TIDAL Mar 14 16:59:43 wyse-bw volumio[1323]: info: Successfully Updated MyVolumio device Mar 14 16:59:43 wyse-bw volumio[1323]: info: Successfully retrieved User Subscription From TIDAL Mar 14 16:59:43 wyse-bw volumio[1323]: info: Adding TIDAL to Browse Sources Mar 14 16:59:43 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 14 16:59:43 wyse-bw volumio[1323]: info: [1741967983472] CoreMusicLibrary::Adding element TIDAL Mar 14 16:59:43 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 16:59:43 wyse-bw volumio[1323]: Cannot find translation for source Randomizer Mar 14 16:59:43 wyse-bw volumio[1323]: Cannot find translation for source Spotify Mar 14 16:59:43 wyse-bw volumio[1323]: Cannot find translation for source cht-bsw-rt5672 Mar 14 16:59:43 wyse-bw volumio[1323]: Cannot find translation for source QOBUZ Mar 14 16:59:43 wyse-bw volumio[1323]: Cannot find translation for source TIDAL Mar 14 16:59:43 wyse-bw volumio[1323]: info: Stopping AccessToken refresher cron Mar 14 16:59:43 wyse-bw volumio[1323]: info: AccessToken refresher cron started Mar 14 16:59:43 wyse-bw volumio[1323]: info: Adding TIDAL REST API Endpoints Mar 14 16:59:43 wyse-bw systemd[1]: Started mpd.service - Music Player Daemon. Mar 14 16:59:43 wyse-bw sudo[2007]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:43 wyse-bw volumio[1323]: error: updateQueue error: null Mar 14 16:59:44 wyse-bw sudo[2115]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Mar 14 16:59:44 wyse-bw sudo[2115]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:44 wyse-bw systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Mar 14 16:59:44 wyse-bw sudo[2115]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:44 wyse-bw volumio[1323]: info: Volumio BT Module successfully started Mar 14 16:59:44 wyse-bw volumiobt[2117]: 2025-03-14 16:59:44 - Checking if bluealsa is active, disabling it... Mar 14 16:59:44 wyse-bw sudo[2119]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl is-active --quiet bluealsa Mar 14 16:59:44 wyse-bw sudo[2119]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:44 wyse-bw sudo[2119]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:44 wyse-bw volumiobt[2117]: 2025-03-14 16:59:44 - Ensuring Bluetooth directory exists... Mar 14 16:59:44 wyse-bw volumiobt[2122]: sudo: a terminal is required to read the password; either use the -S option to read from standard input or configure an askpass helper Mar 14 16:59:44 wyse-bw sudo[2122]: pam_unix(sudo:auth): conversation failed Mar 14 16:59:44 wyse-bw volumiobt[2122]: sudo: a password is required Mar 14 16:59:44 wyse-bw sudo[2122]: pam_unix(sudo:auth): auth could not identify password for [volumio] Mar 14 16:59:44 wyse-bw sudo[2123]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Mar 14 16:59:44 wyse-bw sudo[2123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:44 wyse-bw volumiobt[2124]: chmod: cannot access '/var/lib/bluetooth': No such file or directory Mar 14 16:59:44 wyse-bw sudo[2123]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:44 wyse-bw volumiobt[2117]: 2025-03-14 16:59:44 - Setting headless DBus environment variables... Mar 14 16:59:44 wyse-bw volumiobt[2117]: 2025-03-14 16:59:44 - Checking if PulseAudio is running... Mar 14 16:59:44 wyse-bw volumiobt[2117]: 2025-03-14 16:59:44 - Starting PulseAudio... Mar 14 16:59:44 wyse-bw volumio[1323]: info: TidalConnect service stoped! Mar 14 16:59:44 wyse-bw sudo[2130]: volumio : PWD=/ ; USER=volumio ; COMMAND=/usr/bin/pulseaudio --high-priority=true --realtime=yes --start Mar 14 16:59:44 wyse-bw sudo[2130]: pam_unix(sudo:session): session opened for user volumio(uid=1000) by (uid=1000) Mar 14 16:59:44 wyse-bw volumio[1323]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 14 16:59:44 wyse-bw volumio[1323]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 14 16:59:44 wyse-bw sudo[2141]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 14 16:59:44 wyse-bw sudo[2141]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:44 wyse-bw systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Mar 14 16:59:44 wyse-bw sudo[2141]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:44 wyse-bw dbus-daemon[725]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.44' (uid=1000 pid=2154 comm="/usr/bin/pulseaudio --high-priority=true --realtim") Mar 14 16:59:44 wyse-bw systemd[1]: Starting bluetooth.service - Bluetooth service... Mar 14 16:59:44 wyse-bw volumio[1323]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 14 16:59:44 wyse-bw bluetoothd[2164]: Bluetooth daemon 5.66 Mar 14 16:59:44 wyse-bw bluetoothd[2164]: src/main.c:check_options() Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Mar 14 16:59:44 wyse-bw bluetoothd[2164]: src/main.c:check_options() Unknown key Disable for group General in /etc/bluetooth/main.conf Mar 14 16:59:44 wyse-bw bluetoothd[2164]: src/main.c:check_options() Unknown key MultiProfile for group General in /etc/bluetooth/main.conf Mar 14 16:59:44 wyse-bw dbus-daemon[725]: [system] Successfully activated service 'org.bluez' Mar 14 16:59:44 wyse-bw systemd[1]: Started bluetooth.service - Bluetooth service. Mar 14 16:59:44 wyse-bw bluetoothd[2164]: Starting SDP server Mar 14 16:59:44 wyse-bw bluetoothd[2164]: Excluding (cli) sap Mar 14 16:59:44 wyse-bw pulseaudio[2154]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 14 16:59:44 wyse-bw pulseaudio[2154]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 14 16:59:44 wyse-bw sudo[2130]: pam_unix(sudo:session): session closed for user volumio Mar 14 16:59:44 wyse-bw kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Mar 14 16:59:44 wyse-bw kernel: Bluetooth: BNEP filters: protocol multicast Mar 14 16:59:44 wyse-bw kernel: Bluetooth: BNEP socket layer initialized Mar 14 16:59:44 wyse-bw dbus-daemon[725]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.45' (uid=0 pid=2164 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap -") Mar 14 16:59:44 wyse-bw bluetoothd[2164]: Bluetooth management interface 1.22 initialized Mar 14 16:59:44 wyse-bw volumio[1323]: info: Executing endpoint tc_getconfig Mar 14 16:59:44 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 14 16:59:44 wyse-bw vtcs[2160]: STARTING TidalConnect services, version: 1.5.0.45 Mar 14 16:59:45 wyse-bw systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Mar 14 16:59:45 wyse-bw volumio[1323]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 14 16:59:45 wyse-bw vtcs[2160]: STARTED TidalConnect services. Mar 14 16:59:45 wyse-bw volumio[1323]: info: Executing endpoint tc_connect Mar 14 16:59:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 14 16:59:45 wyse-bw volumio[1323]: info: Connecting to TidalConnect Mar 14 16:59:45 wyse-bw volumio[1323]: info: CoreCommandRouter::servicePushState Mar 14 16:59:45 wyse-bw volumio[1323]: info: CoreStateMachine::pushState Mar 14 16:59:45 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:45 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioPushState Mar 14 16:59:45 wyse-bw volumio[1323]: info: MRS: Pushing multiroomSync output update for this device Mar 14 16:59:45 wyse-bw volumio[1323]: info: MRS: Pushing multiroomSync output Mar 14 16:59:45 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:45 wyse-bw volumio[1323]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Mar 14 16:59:45 wyse-bw volumio[1323]: info: CoreCommandRouter::servicePushState Mar 14 16:59:45 wyse-bw volumio[1323]: info: CoreStateMachine::pushState Mar 14 16:59:45 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:45 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioPushState Mar 14 16:59:45 wyse-bw volumio[1323]: info: MRS: Pushing multiroomSync output update for this device Mar 14 16:59:45 wyse-bw volumio[1323]: info: MRS: Pushing multiroomSync output Mar 14 16:59:45 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:45 wyse-bw volumio[1323]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Mar 14 16:59:45 wyse-bw volumio[1323]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Mar 14 16:59:45 wyse-bw volumio[1323]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Mar 14 16:59:45 wyse-bw dbus-daemon[725]: [system] Successfully activated service 'org.freedesktop.hostname1' Mar 14 16:59:45 wyse-bw systemd[1]: Started systemd-hostnamed.service - Hostname Service. Mar 14 16:59:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 14 16:59:46 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 16:59:46 wyse-bw volumio[1323]: error: FusionDsp - failed to read local file: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//EQ3' Mar 14 16:59:46 wyse-bw volumio[1323]: info: MRS: Getting audio outputs on start Mar 14 16:59:46 wyse-bw volumio[1323]: info: MRS: Requesting all other devices output Mar 14 16:59:46 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 21 Mar 14 16:59:46 wyse-bw volumiobt[2117]: 2025-03-14 16:59:46 - Applying Bluetooth permissions... Mar 14 16:59:46 wyse-bw sudo[2184]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Mar 14 16:59:46 wyse-bw sudo[2184]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 14 16:59:46 wyse-bw volumiobt[2185]: chmod: cannot access '/var/lib/bluetooth': No such file or directory Mar 14 16:59:46 wyse-bw sudo[2184]: pam_unix(sudo:session): session closed for user root Mar 14 16:59:47 wyse-bw volumiobt[2117]: 2025-03-14 16:59:47 - Waiting for Bluetooth services to stabilize... Mar 14 16:59:47 wyse-bw volumio[1323]: info: TidalConnect service started! Mar 14 16:59:47 wyse-bw volumio[1323]: [Metrics] CommandRouter: 55s 924.98ms Mar 14 16:59:47 wyse-bw volumio[1323]: info: CoreCommandRouter::volumiosetStartupVolume Mar 14 16:59:47 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 16:59:47 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 16:59:47 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 16:59:47 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 16:59:47 wyse-bw volumio[1323]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 14 16:59:47 wyse-bw volumio[1323]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 14 16:59:47 wyse-bw volumio[1323]: info: camilladsp stopping service pid 1954... Mar 14 16:59:47 wyse-bw volumio[1323]: grep: /proc/1954/cmdline: binary file matches Mar 14 16:59:47 wyse-bw volumio[1323]: info: camilladsp service terminated, instance 1 Mar 14 16:59:47 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 16:59:47 wyse-bw volumio[1323]: info: camilladsp service started and running in background, instance 1 Mar 14 16:59:48 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 16:59:48 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 16:59:48 wyse-bw volumio[1323]: info: Discovery: Getting this device information Mar 14 16:59:48 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:48 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:48 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 16:59:48 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 14 16:59:48 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 14 16:59:48 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 14 16:59:49 wyse-bw volumiobt[2117]: 2025-03-14 16:59:49 - Ensuring Bluetooth is powered on... Mar 14 16:59:49 wyse-bw volumiobt[2216]: No default controller available Mar 14 16:59:50 wyse-bw volumiobt[2117]: 2025-03-14 16:59:50 - Setting Bluetooth discoverable and pairable... Mar 14 16:59:50 wyse-bw volumiobt[2219]: [156B blob data] Mar 14 16:59:50 wyse-bw volumiobt[2219]: No default controller available Mar 14 16:59:50 wyse-bw volumiobt[2219]: [bluetooth]# pairable on Mar 14 16:59:50 wyse-bw volumiobt[2219]: No default controller available Mar 14 16:59:50 wyse-bw volumiobt[2219]: [bluetooth]# agent off Mar 14 16:59:50 wyse-bw volumiobt[2219]: No agent is registered Mar 14 16:59:50 wyse-bw volumiobt[2219]: [bluetooth]# Mar 14 16:59:50 wyse-bw volumiobt[2117]: 2025-03-14 16:59:50 - Registering Bluetooth agent... Mar 14 16:59:50 wyse-bw volumiobt[2224]: No agent is registered Mar 14 16:59:50 wyse-bw volumiobt[2117]: 2025-03-14 16:59:50 - Agent registered successfully. Mar 14 16:59:50 wyse-bw volumiobt[2117]: 2025-03-14 16:59:50 - Starting simple agent... Mar 14 16:59:50 wyse-bw volumio[1323]: info: CALLMETHOD: audio_interface fusiondsp choosedsp [object Object] Mar 14 16:59:50 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , choosedsp Mar 14 16:59:50 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 16:59:50 wyse-bw volumio[1323]: info: FusionDsp - Nulleq applied Mar 14 16:59:50 wyse-bw volumio[1323]: info: FusionDsp - Reload response: {"Reload":{"result":"Error"}} Mar 14 16:59:51 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 16:59:51 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 16:59:51 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 22 Mar 14 16:59:53 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 14 16:59:53 wyse-bw volumio[1323]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 14 16:59:53 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 14 16:59:53 wyse-bw volumio[1323]: info: Received Get System Version Mar 14 16:59:53 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 16:59:53 wyse-bw volumio[1323]: info: Received Get System Info Mar 14 16:59:53 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 16:59:53 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 16:59:53 wyse-bw volumio[1323]: info: Discovery: Getting this device information Mar 14 16:59:53 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 16:59:53 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 16:59:53 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 16:59:54 wyse-bw volumio[1323]: 0+0 records in Mar 14 16:59:54 wyse-bw volumio[1323]: 0+0 records out Mar 14 16:59:54 wyse-bw volumio[1323]: 0 bytes copied, 0.000165976 s, 0.0 kB/s Mar 14 16:59:54 wyse-bw volumio[1323]: info: BOOT COMPLETED Mar 14 16:59:54 wyse-bw volumio[1323]: info: CALLMETHOD: audio_interface fusiondsp updatelist Mar 14 16:59:54 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , updatelist Mar 14 16:59:54 wyse-bw volumio[1323]: info: FusionDsp - wget 'https://raw.githubusercontent.com/jaakkopasanen/AutoEq//master/results//README.md' Mar 14 16:59:55 wyse-bw volumio[1323]: --2025-03-14 16:59:54-- https://raw.githubusercontent.com/jaakkopasanen/AutoEq//master/results//README.md Mar 14 16:59:55 wyse-bw volumio[1323]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.108.133, 185.199.111.133, 185.199.110.133, ... Mar 14 16:59:55 wyse-bw volumio[1323]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.108.133|:443... connected. Mar 14 16:59:55 wyse-bw volumio[1323]: HTTP request sent, awaiting response... 301 Moved Permanently Mar 14 16:59:55 wyse-bw volumio[1323]: Location: /jaakkopasanen/AutoEq/master/results/README.md [following] Mar 14 16:59:55 wyse-bw volumio[1323]: --2025-03-14 16:59:55-- https://raw.githubusercontent.com/jaakkopasanen/AutoEq/master/results/README.md Mar 14 16:59:55 wyse-bw volumio[1323]: Reusing existing connection to raw.githubusercontent.com:443. Mar 14 16:59:55 wyse-bw volumio[1323]: HTTP request sent, awaiting response... 200 OK Mar 14 16:59:55 wyse-bw volumio[1323]: Length: 406094 (397K) [text/plain] Mar 14 16:59:55 wyse-bw volumio[1323]: Saving to: ‘/data/plugins/audio_interface/fusiondsp/downloadedlist.txt’ Mar 14 16:59:55 wyse-bw volumio[1323]: 0K .......... .......... .......... .......... .......... 12% 1.22M 0s Mar 14 16:59:55 wyse-bw volumio[1323]: 50K .......... .......... .......... .......... .......... 25% 803K 0s Mar 14 16:59:55 wyse-bw volumio[1323]: 100K .......... .......... .......... .......... .......... 37% 1.45M 0s Mar 14 16:59:55 wyse-bw volumio[1323]: 150K .......... .......... .......... .......... .......... 50% 1.48M 0s Mar 14 16:59:55 wyse-bw volumio[1323]: 200K .......... .......... .......... .......... .......... 63% 1.32M 0s Mar 14 16:59:55 wyse-bw volumio[1323]: 250K .......... .......... .......... .......... .......... 75% 1.27M 0s Mar 14 16:59:55 wyse-bw volumio[1323]: 300K .......... .......... .......... .......... .......... 88% 1.25M 0s Mar 14 16:59:55 wyse-bw volumio[1323]: 350K .......... .......... .......... .......... ...... 100% 1.78M=0.3s Mar 14 16:59:55 wyse-bw volumio[1323]: 2025-03-14 16:59:55 (1.25 MB/s) - ‘/data/plugins/audio_interface/fusiondsp/downloadedlist.txt’ saved [406094/406094] Mar 14 16:59:55 wyse-bw volumio[1323]: info: FusionDsp - Preprocessed 5173 lines into /data/plugins/audio_interface/fusiondsp/headphone_options.json Mar 14 16:59:55 wyse-bw volumio[1323]: 0+0 records in Mar 14 16:59:55 wyse-bw volumio[1323]: 0+0 records out Mar 14 16:59:55 wyse-bw volumio[1323]: 0 bytes copied, 0.000151101 s, 0.0 kB/s Mar 14 16:59:56 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 16:59:56 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 16:59:56 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 23 Mar 14 16:59:56 wyse-bw volumio[1323]: 0+0 records in Mar 14 16:59:56 wyse-bw volumio[1323]: 0+0 records out Mar 14 16:59:56 wyse-bw volumio[1323]: 0 bytes copied, 0.000118639 s, 0.0 kB/s Mar 14 16:59:58 wyse-bw volumio[1323]: 0+0 records in Mar 14 16:59:58 wyse-bw volumio[1323]: 0+0 records out Mar 14 16:59:58 wyse-bw volumio[1323]: 0 bytes copied, 0.000116801 s, 0.0 kB/s Mar 14 16:59:59 wyse-bw volumio[1323]: 0+0 records in Mar 14 16:59:59 wyse-bw volumio[1323]: 0+0 records out Mar 14 16:59:59 wyse-bw volumio[1323]: 0 bytes copied, 0.000113776 s, 0.0 kB/s Mar 14 17:00:00 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:00 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:00 wyse-bw volumio[1323]: 0 bytes copied, 0.000113689 s, 0.0 kB/s Mar 14 17:00:01 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:01 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:01 wyse-bw volumio[1323]: 0 bytes copied, 0.000165427 s, 0.0 kB/s Mar 14 17:00:01 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 24 Mar 14 17:00:02 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:02 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:02 wyse-bw volumio[1323]: 0 bytes copied, 0.000155002 s, 0.0 kB/s Mar 14 17:00:03 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:03 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:03 wyse-bw volumio[1323]: 0 bytes copied, 0.000122614 s, 0.0 kB/s Mar 14 17:00:04 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:04 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:04 wyse-bw volumio[1323]: 0 bytes copied, 0.000113114 s, 0.0 kB/s Mar 14 17:00:05 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:05 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:05 wyse-bw volumio[1323]: 0 bytes copied, 0.000143764 s, 0.0 kB/s Mar 14 17:00:06 wyse-bw volumio[1323]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Mar 14 17:00:06 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:06 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:06 wyse-bw volumio[1323]: 0 bytes copied, 0.000152427 s, 0.0 kB/s Mar 14 17:00:06 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 25 Mar 14 17:00:07 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:07 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:07 wyse-bw volumio[1323]: 0 bytes copied, 0.000175077 s, 0.0 kB/s Mar 14 17:00:08 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:08 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:08 wyse-bw volumio[1323]: 0 bytes copied, 0.000178077 s, 0.0 kB/s Mar 14 17:00:09 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:09 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:09 wyse-bw volumio[1323]: 0 bytes copied, 0.000150014 s, 0.0 kB/s Mar 14 17:00:10 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:10 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:10 wyse-bw volumio[1323]: 0 bytes copied, 0.000155152 s, 0.0 kB/s Mar 14 17:00:11 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:11 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:11 wyse-bw volumio[1323]: 0 bytes copied, 0.000159064 s, 0.0 kB/s Mar 14 17:00:11 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 26 Mar 14 17:00:12 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:12 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:12 wyse-bw volumio[1323]: 0 bytes copied, 0.000163189 s, 0.0 kB/s Mar 14 17:00:13 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:13 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:13 wyse-bw volumio[1323]: 0 bytes copied, 0.000170865 s, 0.0 kB/s Mar 14 17:00:14 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:14 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:14 wyse-bw volumio[1323]: 0 bytes copied, 0.000111189 s, 0.0 kB/s Mar 14 17:00:15 wyse-bw systemd[1]: systemd-hostnamed.service: Deactivated successfully. Mar 14 17:00:15 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:15 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:15 wyse-bw volumio[1323]: 0 bytes copied, 0.000133102 s, 0.0 kB/s Mar 14 17:00:16 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 27 Mar 14 17:00:16 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:16 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:16 wyse-bw volumio[1323]: 0 bytes copied, 0.000149439 s, 0.0 kB/s Mar 14 17:00:17 wyse-bw volumio[1323]: info: CALLMETHOD: audio_interface fusiondsp importeq [object Object] Mar 14 17:00:17 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , importeq Mar 14 17:00:17 wyse-bw volumio[1323]: info: FusionDsp - namepath /oratory1990/over-ear/Sony%20WH-1000XM3 name Sony WH-1000XM3 Mar 14 17:00:17 wyse-bw volumio[1323]: info: FusionDsp - wget 'https://raw.githubusercontent.com/jaakkopasanen/AutoEq/master/results/oratory1990/over-ear/Sony%20WH-1000XM3/Sony%20WH-1000XM3%20ParametricEQ.txt Mar 14 17:00:18 wyse-bw volumio[1323]: --2025-03-14 17:00:17-- https://raw.githubusercontent.com/jaakkopasanen/AutoEq/master/results/oratory1990/over-ear/Sony%20WH-1000XM3/Sony%20WH-1000XM3%20ParametricEQ.txt Mar 14 17:00:18 wyse-bw volumio[1323]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.110.133, 185.199.109.133, 185.199.108.133, ... Mar 14 17:00:18 wyse-bw volumio[1323]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.110.133|:443... connected. Mar 14 17:00:18 wyse-bw volumio[1323]: HTTP request sent, awaiting response... 200 OK Mar 14 17:00:18 wyse-bw volumio[1323]: Length: 480 [text/plain] Mar 14 17:00:18 wyse-bw volumio[1323]: Saving to: ‘/tmp/EQfile.txt’ Mar 14 17:00:18 wyse-bw volumio[1323]: 0K 100% 10.7M=0s Mar 14 17:00:18 wyse-bw volumio[1323]: 2025-03-14 17:00:18 (10.7 MB/s) - ‘/tmp/EQfile.txt’ saved [480/480] Mar 14 17:00:18 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:18 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:18 wyse-bw volumio[1323]: 0 bytes copied, 0.000159502 s, 0.0 kB/s Mar 14 17:00:18 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 17:00:18 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 17:00:18 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 17:00:18 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 17:00:18 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 17:00:18 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 17:00:18 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 17:00:18 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 17:00:18 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 17:00:18 wyse-bw volumio[1323]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 14 17:00:18 wyse-bw volumio[1323]: error: FusionDsp - Reload WebSocket error: [object Object] Mar 14 17:00:18 wyse-bw volumio[1323]: error: FusionDsp - Reload WebSocket error: [object Object] Mar 14 17:00:18 wyse-bw volumio[1323]: error: FusionDsp - Reload WebSocket error: [object Object] Mar 14 17:00:18 wyse-bw volumio[1323]: error: FusionDsp - Reload WebSocket error: [object Object] Mar 14 17:00:18 wyse-bw volumio[1323]: error: FusionDsp - Reload WebSocket error: [object Object] Mar 14 17:00:18 wyse-bw volumio[1323]: error: FusionDsp - Reload WebSocket error: [object Object] Mar 14 17:00:18 wyse-bw volumio[1323]: error: FusionDsp - Reload WebSocket error: [object Object] Mar 14 17:00:18 wyse-bw volumio[1323]: error: FusionDsp - Reload WebSocket error: [object Object] Mar 14 17:00:18 wyse-bw volumio[1323]: error: FusionDsp - Reload WebSocket error: [object Object] Mar 14 17:00:18 wyse-bw volumio[1323]: error: FusionDsp - Reload WebSocket error: [object Object] Mar 14 17:00:18 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 17:00:18 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 17:00:18 wyse-bw volumio[1323]: info: Discovery: Getting this device information Mar 14 17:00:18 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 17:00:18 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 17:00:18 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 17:00:19 wyse-bw volumio[1323]: 0+0 records in Mar 14 17:00:19 wyse-bw volumio[1323]: 0+0 records out Mar 14 17:00:19 wyse-bw volumio[1323]: 0 bytes copied, 0.000125289 s, 0.0 kB/s Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 17:00:19 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 17:00:22 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 28 Mar 14 17:00:26 wyse-bw volumio[1323]: info: CALLMETHOD: audio_interface fusiondsp saveequalizerpreset [object Object] Mar 14 17:00:26 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , saveequalizerpreset Mar 14 17:00:26 wyse-bw volumio[1323]: info: FusionDsp - File "/data/INTERNAL/FusionDsp/presets/PEQ/Sony WH-1000xM3.json" created successfully. Mar 14 17:00:27 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 17:00:27 wyse-bw volumio[1323]: info: CoreCommandRouter::Close All Modals sent Mar 14 17:00:27 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 23 Mar 14 17:00:32 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 17:00:32 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 14 17:00:32 wyse-bw volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 17:00:32 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 24 Mar 14 17:00:36 wyse-bw volumio[1323]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Mar 14 17:00:37 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetState Mar 14 17:00:37 wyse-bw volumio[1323]: info: CorePlayQueue::getTrack 0 Mar 14 17:00:37 wyse-bw volumio[1323]: info: CoreCommandRouter::volumioGetQueue Mar 14 17:00:37 wyse-bw volumio[1323]: info: CoreStateMachine::getQueue Mar 14 17:00:37 wyse-bw volumio[1323]: info: CorePlayQueue::getQueue Mar 14 17:00:37 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 25 Mar 14 17:00:39 wyse-bw volumio[1323]: info: Executing endpoint metavolumio Mar 14 17:00:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 14 17:00:39 wyse-bw volumio[1323]: info: Executing endpoint metavolumio Mar 14 17:00:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 14 17:00:39 wyse-bw volumio[1323]: info: Executing endpoint metavolumio Mar 14 17:00:39 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 14 17:00:39 wyse-bw volumio[1323]: error: Failed request for metavolumio API Mar 14 17:00:42 wyse-bw volumio[1323]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 4 Transport: polling Total Clients: 26 Mar 14 17:00:45 wyse-bw volumio[1323]: Searching all installed plugins Mar 14 17:00:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 17:00:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: , search Mar 14 17:00:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: mpd , search Mar 14 17:00:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Mar 14 17:00:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Mar 14 17:00:45 wyse-bw volumio[1323]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Mar 14 17:00:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: webradio , search Mar 14 17:00:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: randomizer , search Mar 14 17:00:45 wyse-bw volumio[1323]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin randomizer Mar 14 17:00:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: spop , search Mar 14 17:00:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: smart_inputs , search Mar 14 17:00:45 wyse-bw volumio[1323]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin smart_inputs Mar 14 17:00:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 14 17:00:45 wyse-bw volumio[1323]: info: CoreCommandRouter::executeOnPlugin: tidal , search Mar 14 17:00:45 wyse-bw volumio[1323]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 14 17:00:45 wyse-bw volumio[1323]: TypeError: Cannot read properties of undefined (reading 'length') Mar 14 17:00:45 wyse-bw volumio[1323]: at /volumio/node_modules/libxmljs/dist/lib/parse.js:186:126 Mar 14 17:00:45 wyse-bw volumio[1323]: at Object.parseXml (/volumio/node_modules/libxmljs/dist/lib/parse.js:185:49) Mar 14 17:00:45 wyse-bw volumio[1323]: at /volumio/app/plugins/music_service/webradio/index.js:949:31 Mar 14 17:00:45 wyse-bw volumio[1323]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Mar 14 17:00:45 wyse-bw volumio[1323]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 14 17:00:45 wyse-bw sudo[2486]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-03-14 16:59' Mar 14 17:00:45 wyse-bw sudo[2486]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="30b940f30730969a1c56b277277ec58998d851c0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Mar 12 10:20:21 UTC 2025" VOLUMIO_VERSION="0.044" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9a8c3e1f833763bce6b5726c17413d36"