-- Logs begin at Fri 2024-08-30 19:22:17 CDT, end at Fri 2024-08-30 19:52:19 CDT. -- Aug 30 19:51:01 volumio volumio-remote-updater[841]: [2024-08-31 00:51:01] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Aug 30 19:51:05 volumio volumio[1138]: info: Checking if install.sh is present Aug 30 19:51:05 volumio volumio[1138]: info: Executing install.sh Aug 30 19:51:05 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Aug 30 19:51:05 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Aug 30 19:51:05 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Aug 30 19:51:05 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 30 19:51:05 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 30 19:51:05 volumio sudo[6846]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/Systeminfo/install.sh Aug 30 19:51:05 volumio sudo[6846]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:51:05 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 30 19:51:05 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 30 19:51:05 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Aug 30 19:51:05 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Aug 30 19:51:05 volumio volumio[1138]: info: Installing systeminfo Aug 30 19:51:05 volumio volumio[1138]: info: Configuration file doesn't exist, nothing to do Aug 30 19:51:05 volumio volumio[1138]: info: Detected cpu architecture as x86_64 Aug 30 19:51:05 volumio sudo[6851]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/user_interface/Systeminfo/c/hw_params_amd64 /data/plugins/user_interface/Systeminfo/hw_params Aug 30 19:51:05 volumio sudo[6851]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:51:05 volumio sudo[6851]: pam_unix(sudo:session): session closed for user root Aug 30 19:51:05 volumio sudo[6853]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/user_interface/Systeminfo/hw_params Aug 30 19:51:05 volumio sudo[6853]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:51:05 volumio sudo[6853]: pam_unix(sudo:session): session closed for user root Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:05 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:05 volumio sudo[6855]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/user_interface/Systeminfo/firmware.sh Aug 30 19:51:05 volumio sudo[6855]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:51:05 volumio sudo[6855]: pam_unix(sudo:session): session closed for user root Aug 30 19:51:05 volumio sudo[6846]: pam_unix(sudo:session): session closed for user root Aug 30 19:51:05 volumio volumio[1138]: info: Install script completed Aug 30 19:51:05 volumio volumio[1138]: info: Adding reference to registry Aug 30 19:51:05 volumio volumio[1138]: info: Done installing plugin. Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 19:51:05 volumio volumio[1138]: info: Folder /tmp/plugins removed Aug 30 19:51:05 volumio volumio[1138]: info: Folder /tmp/downloaded_plugin.zip removed Aug 30 19:51:05 volumio volumio[1138]: info: Received Get System Info Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:51:05 volumio volumio[1138]: info: Discovery: Getting this device information Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:05 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:05 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:05 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:05 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 19:51:05 volumio volumio[1138]: info: Received Get System Info Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:51:05 volumio volumio[1138]: info: Discovery: Getting this device information Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:05 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:05 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:05 volumio volumio[1138]: info: Listing playlists Aug 30 19:51:05 volumio volumio[1138]: Plugin install end detected on script Aug 30 19:51:05 volumio volumio[1138]: info: Folder /data/temp removed Aug 30 19:51:05 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 30 19:51:06 volumio volumio[1138]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Aug 30 19:51:06 volumio volumio[1138]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Aug 30 19:51:06 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:06 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:06 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46 Aug 30 19:51:06 volumio volumio-remote-updater[841]: [2024-08-31 00:51:06] [connect] Successful connection Aug 30 19:51:06 volumio volumio-remote-updater[841]: [2024-08-31 00:51:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725065466 101 Aug 30 19:51:06 volumio volumio[1138]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 14 Aug 30 19:51:10 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:10 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:11 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:11 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:11 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:12 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:12 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:12 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:14 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:14 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:14 volumio volumio[1138]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/buster/amd64 Aug 30 19:51:14 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:14 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:17 volumio volumio[1138]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/buster/amd64 Aug 30 19:51:17 volumio volumio[1138]: info: Folder /tmp/plugins removed Aug 30 19:51:17 volumio volumio[1138]: info: Check plugin dependencies Aug 30 19:51:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 19:51:17 volumio volumio[1138]: info: Checking if plugin already exists Aug 30 19:51:17 volumio volumio[1138]: info: Rename folder Aug 30 19:51:17 volumio volumio[1138]: info: Folder /tmp/downloaded_plugin.zip removed Aug 30 19:51:17 volumio volumio[1138]: info: Move to category Aug 30 19:51:22 volumio volumio[1138]: info: Checking if install.sh is present Aug 30 19:51:22 volumio volumio[1138]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/Systeminfo/volumio/buster/amd64 Aug 30 19:51:22 volumio volumio[1138]: info: Executing install.sh Aug 30 19:51:22 volumio sudo[6933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/now_playing/install.sh Aug 30 19:51:22 volumio sudo[6933]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:51:22 volumio volumio[1138]: info: Installing geo-tz node dependency Aug 30 19:51:24 volumio volumio[1138]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/Systeminfo/volumio/buster/amd64 Aug 30 19:51:24 volumio volumio[1138]: info: Folder /tmp/plugins removed Aug 30 19:51:24 volumio volumio[1138]: info: Check plugin dependencies Aug 30 19:51:24 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 19:51:24 volumio volumio[1138]: info: Checking if plugin already exists Aug 30 19:51:24 volumio volumio[1138]: info: An error occurred installing the plugin. Rolling back config Aug 30 19:51:24 volumio volumio[1138]: info: Plugin folders cleanup Aug 30 19:51:24 volumio volumio[1138]: info: Scanning into folder /volumio/app/plugins/ Aug 30 19:51:24 volumio volumio[1138]: info: Scanning category audio_interface Aug 30 19:51:24 volumio volumio[1138]: info: Scanning category miscellanea Aug 30 19:51:24 volumio volumio[1138]: info: Scanning category music_service Aug 30 19:51:24 volumio volumio[1138]: info: Scanning category plugins.json Aug 30 19:51:24 volumio volumio[1138]: info: Scanning category system_controller Aug 30 19:51:24 volumio volumio[1138]: info: Scanning category user_interface Aug 30 19:51:24 volumio volumio[1138]: info: Scanning into folder /data/plugins/ Aug 30 19:51:24 volumio volumio[1138]: info: Scanning category music_service Aug 30 19:51:24 volumio volumio[1138]: info: Scanning category system_controller Aug 30 19:51:24 volumio volumio[1138]: info: Scanning category system_hardware Aug 30 19:51:24 volumio volumio[1138]: info: Scanning category user_interface Aug 30 19:51:24 volumio volumio[1138]: info: Plugin folders cleanup completed Aug 30 19:51:24 volumio volumio[1138]: info: Error: Error Aug 30 19:51:24 volumio volumio[1138]: info: Folder /tmp/plugins removed Aug 30 19:51:24 volumio volumio[1138]: info: Folder /tmp/downloaded_plugin.zip removed Aug 30 19:51:24 volumio volumio[1138]: info: Folder /tmp/downloaded_plugin.zip removed Aug 30 19:51:24 volumio volumio[1138]: info: Folder /data/temp removed Aug 30 19:51:26 volumio sudo[6953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 19:51:26 volumio sudo[6953]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:51:26 volumio sudo[6953]: pam_unix(sudo:session): session closed for user root Aug 30 19:51:26 volumio sudo[6956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 19:51:26 volumio sudo[6956]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:51:26 volumio sudo[6956]: pam_unix(sudo:session): session closed for user root Aug 30 19:51:26 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Aug 30 19:51:26 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 19:51:27 volumio volumio[1138]: info: Received Get System Info Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:51:27 volumio volumio[1138]: info: Discovery: Getting this device information Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:27 volumio volumio[1138]: info: Listing playlists Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 19:51:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 30 19:51:28 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 19:51:28 volumio volumio[1138]: info: Received Get System Info Aug 30 19:51:28 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:51:28 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:51:28 volumio volumio[1138]: info: Discovery: Getting this device information Aug 30 19:51:28 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:28 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:28 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:51:28 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 30 19:51:29 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 19:51:29 volumio volumio[1138]: info: Received Get System Info Aug 30 19:51:29 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:51:29 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:51:29 volumio volumio[1138]: info: Discovery: Getting this device information Aug 30 19:51:29 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:29 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:29 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:51:36 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:51:43 volumio volumio[1138]: info: + geo-tz@8.0.2 Aug 30 19:51:43 volumio volumio[1138]: info: added 23 packages from 25 contributors and audited 347 packages in 20.526s Aug 30 19:51:43 volumio volumio[1138]: info: Aug 30 19:51:43 volumio volumio[1138]: info: 21 packages are looking for funding Aug 30 19:51:43 volumio volumio[1138]: info: run `npm fund` for details Aug 30 19:51:43 volumio volumio[1138]: info: Aug 30 19:51:43 volumio volumio[1138]: info: found 3 moderate severity vulnerabilities Aug 30 19:51:43 volumio volumio[1138]: info: run `npm audit fix` to fix them, or `npm audit` for details Aug 30 19:51:43 volumio volumio[1138]: info: Creating user directories (if not exist) Aug 30 19:51:43 volumio sudo[6933]: pam_unix(sudo:session): session closed for user root Aug 30 19:51:43 volumio volumio[1138]: info: Now Playing plugin installed Aug 30 19:51:43 volumio volumio[1138]: Plugin install end detected on script Aug 30 19:51:43 volumio volumio[1138]: info: Install script completed Aug 30 19:51:43 volumio volumio[1138]: info: Adding reference to registry Aug 30 19:51:43 volumio volumio[1138]: info: Done installing plugin. Aug 30 19:51:43 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 19:51:43 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 19:51:43 volumio volumio[1138]: info: Folder /data/temp removed Aug 30 19:51:43 volumio volumio[1138]: info: Folder /tmp/plugins removed Aug 30 19:51:43 volumio volumio[1138]: info: Folder /tmp/downloaded_plugin.zip removed Aug 30 19:51:44 volumio volumio[1138]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/amd64 Aug 30 19:51:45 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 19:51:45 volumio volumio[1138]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 30 19:51:45 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 30 19:51:45 volumio volumio[1138]: info: Received Get System Version Aug 30 19:51:45 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 19:51:45 volumio volumio[1138]: info: Received Get System Info Aug 30 19:51:45 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:51:45 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:51:45 volumio volumio[1138]: info: Discovery: Getting this device information Aug 30 19:51:45 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:51:45 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:51:45 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:51:49 volumio volumio[1138]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/amd64 Aug 30 19:51:49 volumio volumio[1138]: info: Folder /tmp/plugins removed Aug 30 19:51:49 volumio volumio[1138]: info: Check plugin dependencies Aug 30 19:51:49 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 19:51:49 volumio volumio[1138]: info: Checking if plugin already exists Aug 30 19:51:49 volumio volumio[1138]: info: Rename folder Aug 30 19:51:49 volumio volumio[1138]: info: Folder /tmp/downloaded_plugin.zip removed Aug 30 19:51:49 volumio volumio[1138]: info: Move to category Aug 30 19:52:01 volumio volumio-remote-updater[841]: [2024-08-31 00:52:01] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Aug 30 19:52:06 volumio volumio-remote-updater[841]: [2024-08-31 00:52:06] [connect] Successful connection Aug 30 19:52:07 volumio volumio[1138]: info: Checking if install.sh is present Aug 30 19:52:07 volumio volumio[1138]: info: Executing install.sh Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 30 19:52:07 volumio volumio-remote-updater[841]: [2024-08-31 00:52:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725065526 101 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 9 Aug 30 19:52:07 volumio sudo[6982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Aug 30 19:52:07 volumio sudo[6982]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Aug 30 19:52:07 volumio volumio[1138]: info: creating filters folder and copying demo filters Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Aug 30 19:52:07 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 20 Aug 30 19:52:07 volumio volumio[1138]: info: copying demo flters Aug 30 19:52:07 volumio volumio[1138]: info: Received Get System Info Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:52:07 volumio volumio[1138]: info: Discovery: Getting this device information Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:52:07 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:52:07 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:52:07 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 19:52:07 volumio volumio[1138]: info: Received Get System Info Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:52:07 volumio volumio[1138]: info: Discovery: Getting this device information Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:52:07 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:52:07 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:52:07 volumio sudo[7003]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt update Aug 30 19:52:07 volumio sudo[7003]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:07 volumio volumio[1138]: info: Listing playlists Aug 30 19:52:07 volumio volumio[1138]: info: Installing/fusiondsp dependencies Aug 30 19:52:07 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 30 19:52:08 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:08 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:08 volumio volumio[1138]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 21 Aug 30 19:52:08 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:52:08 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:52:08 volumio volumio[1138]: info: Hit:1 https://deb.nodesource.com/node_14.x buster InRelease Aug 30 19:52:08 volumio volumio[1138]: info: Hit:2 http://deb.debian.org/debian buster InRelease Aug 30 19:52:08 volumio volumio[1138]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 22 Aug 30 19:52:08 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:52:08 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:52:08 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46 Aug 30 19:52:08 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:08 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:08 volumio volumio[1138]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 23 Aug 30 19:52:09 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:09 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:09 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:09 volumio volumio[1138]: info: Reading package lists... Aug 30 19:52:09 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:10 volumio volumio[1138]: info: Building dependency tree... Aug 30 19:52:10 volumio volumio[1138]: info: Reading state information... Aug 30 19:52:10 volumio volumio[1138]: info: All packages are up to date. Aug 30 19:52:10 volumio sudo[7003]: pam_unix(sudo:session): session closed for user root Aug 30 19:52:10 volumio sudo[7271]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Aug 30 19:52:10 volumio sudo[7271]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:10 volumio volumio[1138]: info: Reading package lists... Aug 30 19:52:10 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:10 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:10 volumio volumio[1138]: info: Building dependency tree... Aug 30 19:52:10 volumio volumio[1138]: info: Reading state information... Aug 30 19:52:10 volumio volumio[1138]: info: python3-pip is already the newest version (18.1-5). Aug 30 19:52:10 volumio volumio[1138]: info: The following additional packages will be installed: Aug 30 19:52:10 volumio volumio[1138]: info: python3-async-timeout python3-attr python3-multidict python3-yarl Aug 30 19:52:10 volumio volumio[1138]: info: Suggested packages: Aug 30 19:52:10 volumio volumio[1138]: info: python-attr-doc Aug 30 19:52:10 volumio volumio[1138]: info: The following NEW packages will be installed: Aug 30 19:52:10 volumio volumio[1138]: info: python3-aiohttp python3-async-timeout python3-attr python3-multidict Aug 30 19:52:10 volumio volumio[1138]: info: python3-yarl Aug 30 19:52:10 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:10 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:11 volumio volumio[1138]: info: 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. Aug 30 19:52:11 volumio volumio[1138]: info: Need to get 413 kB of archives. Aug 30 19:52:11 volumio volumio[1138]: info: After this operation, 1893 kB of additional disk space will be used. Aug 30 19:52:11 volumio volumio[1138]: info: Get:1 http://deb.debian.org/debian buster/main amd64 python3-multidict amd64 4.5.2-1 [60.6 kB] Aug 30 19:52:11 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:11 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:11 volumio volumio[1138]: info: Get:2 http://deb.debian.org/debian buster/main amd64 python3-yarl amd64 1.3.0-1 [48.3 kB] Aug 30 19:52:11 volumio volumio[1138]: info: Get:3 http://deb.debian.org/debian buster/main amd64 python3-async-timeout all 3.0.1-1 [6292 B] Aug 30 19:52:11 volumio volumio[1138]: info: Get:4 http://deb.debian.org/debian buster/main amd64 python3-attr all 18.2.0-1 [37.3 kB] Aug 30 19:52:11 volumio volumio[1138]: info: Get:5 http://deb.debian.org/debian buster/main amd64 python3-aiohttp amd64 3.5.1-1+deb10u1 [261 kB] Aug 30 19:52:12 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:12 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:52:12 volumio volumio[1138]: info: Fetched 413 kB in 1s (312 kB/s) Aug 30 19:52:12 volumio sudo[7288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 19:52:12 volumio sudo[7288]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:12 volumio sudo[7288]: pam_unix(sudo:session): session closed for user root Aug 30 19:52:12 volumio sudo[7291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 19:52:12 volumio sudo[7291]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:12 volumio sudo[7291]: pam_unix(sudo:session): session closed for user root Aug 30 19:52:12 volumio volumio[1138]: info: Selecting previously unselected package python3-multidict. Aug 30 19:52:12 volumio volumio[1138]: [620B blob data] Aug 30 19:52:12 volumio volumio[1138]: info: Preparing to unpack .../python3-multidict_4.5.2-1_amd64.deb ... Aug 30 19:52:13 volumio volumio[1138]: info: Unpacking python3-multidict (4.5.2-1) ... Aug 30 19:52:13 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.8.212 from 192.168.8.188 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 23 Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:52:13 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 19:52:13 volumio volumio[1138]: info: Received Get System Info Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:52:13 volumio volumio[1138]: info: Discovery: Getting this device information Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:52:13 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:52:13 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:52:13 volumio volumio[1138]: info: Listing playlists Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 19:52:13 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 30 19:52:14 volumio volumio[1138]: info: Selecting previously unselected package python3-yarl. Aug 30 19:52:14 volumio volumio[1138]: info: Preparing to unpack .../python3-yarl_1.3.0-1_amd64.deb ... Aug 30 19:52:14 volumio volumio[1138]: info: Unpacking python3-yarl (1.3.0-1) ... Aug 30 19:52:14 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 19:52:14 volumio volumio[1138]: info: Received Get System Info Aug 30 19:52:14 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:52:14 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:52:14 volumio volumio[1138]: info: Discovery: Getting this device information Aug 30 19:52:14 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:52:14 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:52:14 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:52:15 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 30 19:52:15 volumio volumio[1138]: info: Selecting previously unselected package python3-async-timeout. Aug 30 19:52:15 volumio volumio[1138]: info: Preparing to unpack .../python3-async-timeout_3.0.1-1_all.deb ... Aug 30 19:52:15 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 19:52:15 volumio volumio[1138]: info: Received Get System Info Aug 30 19:52:15 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:52:15 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:52:15 volumio volumio[1138]: info: Discovery: Getting this device information Aug 30 19:52:15 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Aug 30 19:52:15 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Aug 30 19:52:15 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:52:16 volumio volumio[1138]: info: Unpacking python3-async-timeout (3.0.1-1) ... Aug 30 19:52:17 volumio volumio[1138]: info: Selecting previously unselected package python3-attr. Aug 30 19:52:17 volumio volumio[1138]: info: Preparing to unpack .../python3-attr_18.2.0-1_all.deb ... Aug 30 19:52:17 volumio volumio[1138]: info: Unpacking python3-attr (18.2.0-1) ... Aug 30 19:52:17 volumio volumio[1138]: info: Enabling plugin fusiondsp Aug 30 19:52:17 volumio volumio[1138]: info: Loading plugin "fusiondsp"... Aug 30 19:52:17 volumio volumio[1138]: info: Preparing to generate the ALSA configuration file Aug 30 19:52:17 volumio volumio[1138]: info: Asound.conf file unchanged, so no further update is needed Aug 30 19:52:17 volumio volumio[1138]: info: Output device has changed, restarting MPD Aug 30 19:52:17 volumio sudo[7324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 19:52:17 volumio sudo[7324]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:17 volumio sudo[7324]: pam_unix(sudo:session): session closed for user root Aug 30 19:52:17 volumio volumio[1138]: info: Output device has changed, restarting Shairport Sync Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 19:52:17 volumio sudo[7329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 19:52:17 volumio sudo[7329]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:17 volumio systemd[1]: musicservicesshield.service: Succeeded. Aug 30 19:52:17 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Aug 30 19:52:17 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Aug 30 19:52:17 volumio systemd[1]: Stopping Music Player Daemon... Aug 30 19:52:17 volumio systemd[1]: mpd.service: Succeeded. Aug 30 19:52:17 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 19:52:17 volumio volumio[1138]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 19:52:17 volumio volumio[1138]: info: PLUGIN START: fusiondsp Aug 30 19:52:17 volumio volumio[1138]: info: Loading i18n strings for locale en Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: FusionDsp - mixtype--------------------- Hardware Aug 30 19:52:17 volumio volumio[1138]: info: Preparing to generate the ALSA configuration file Aug 30 19:52:17 volumio volumio[1138]: info: Done. Aug 30 19:52:17 volumio volumio[1138]: info: MPD Permissions set Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 30 19:52:17 volumio systemd[1]: Starting Music Player Daemon... Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: Asound.conf file unchanged, so no further update is needed Aug 30 19:52:17 volumio volumio[1138]: info: Output device has changed, restarting MPD Aug 30 19:52:17 volumio sudo[7342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 19:52:17 volumio sudo[7342]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:17 volumio sudo[7334]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 19:52:17 volumio sudo[7334]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:17 volumio sudo[7342]: pam_unix(sudo:session): session closed for user root Aug 30 19:52:17 volumio sudo[7334]: pam_unix(sudo:session): session closed for user root Aug 30 19:52:17 volumio volumio[1138]: info: Output device has changed, restarting Shairport Sync Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 19:52:17 volumio sudo[7346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 19:52:17 volumio sudo[7346]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:17 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 30 19:52:17 volumio systemd[1]: mpd.service: Succeeded. Aug 30 19:52:17 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 19:52:17 volumio systemd[1]: Starting Music Player Daemon... Aug 30 19:52:17 volumio volumio[1138]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 19:52:17 volumio volumio[1138]: info: MPD Permissions set Aug 30 19:52:17 volumio volumio[1138]: info: Starting Shairport Sync Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio sudo[7352]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 19:52:17 volumio sudo[7352]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:17 volumio sudo[7354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 19:52:17 volumio sudo[7354]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:17 volumio sudo[7352]: pam_unix(sudo:session): session closed for user root Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 30 19:52:17 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 19:52:17 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 19:52:17 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 19:52:17 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 19:52:17 volumio sudo[7354]: pam_unix(sudo:session): session closed for user root Aug 30 19:52:17 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:17 volumio volumio[1138]: info: Shairport-Sync Started Aug 30 19:52:18 volumio volumio[1138]: info: Starting Shairport Sync Aug 30 19:52:18 volumio sudo[7368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 19:52:18 volumio sudo[7368]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 19:52:18 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 19:52:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 19:52:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 19:52:18 volumio sudo[7368]: pam_unix(sudo:session): session closed for user root Aug 30 19:52:18 volumio volumio[1138]: info: Shairport-Sync Started Aug 30 19:52:18 volumio mpd[7358]: Aug 30 19:52 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 19:52:18 volumio systemd[1]: Started Music Player Daemon. Aug 30 19:52:18 volumio sudo[7346]: pam_unix(sudo:session): session closed for user root Aug 30 19:52:18 volumio sudo[7329]: pam_unix(sudo:session): session closed for user root Aug 30 19:52:18 volumio volumio[1138]: error: MPD error: The expression evaluated to a falsy value: Aug 30 19:52:18 volumio volumio[1138]: assert.ok(self.idling) Aug 30 19:52:18 volumio volumio[1138]: error: The expression evaluated to a falsy value: Aug 30 19:52:18 volumio volumio[1138]: assert.ok(self.idling) Aug 30 19:52:18 volumio volumio[1138]: error: updateQueue error: null Aug 30 19:52:18 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Aug 30 19:52:18 volumio volumio[7375]: cset: --> shielding system active with Aug 30 19:52:18 volumio volumio[7375]: cset: "system" cpuset of CPUSPEC(1-3) with 209 tasks running Aug 30 19:52:18 volumio volumio[7375]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Aug 30 19:52:18 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Aug 30 19:52:18 volumio volumio[1138]: info: Selecting previously unselected package python3-aiohttp. Aug 30 19:52:18 volumio volumio[1138]: info: Preparing to unpack .../python3-aiohttp_3.5.1-1+deb10u1_amd64.deb ... Aug 30 19:52:18 volumio volumio[1138]: info: Unpacking python3-aiohttp (3.5.1-1+deb10u1) ... Aug 30 19:52:19 volumio volumio[1138]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 30 19:52:19 volumio volumio[1138]: info: camilladsp service started and running in background, instance 1 Aug 30 19:52:19 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:52:19 volumio volumio[1138]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 19:52:19 volumio volumio[1138]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 30 19:52:19 volumio volumio[1138]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 19:52:19 volumio volumio[1138]: info: FusionDsp loaded Aug 30 19:52:19 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:52:19 volumio sudo[7412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 30 19:52:19 volumio sudo[7412]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:52:19 volumio volumio[1138]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 30 19:52:19 volumio volumio[1138]: info: Adding Signal Path Element [object Object] Aug 30 19:52:19 volumio volumio[1138]: info: Adding fusiondspeq DSP Signal Path Element Aug 30 19:52:19 volumio volumio[1138]: info: FusionDsp - ---- installed callbackRead Aug 30 19:52:19 volumio volumio[1138]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 19:52:19 volumio sudo[7412]: pam_unix(sudo:session): session closed for user root Aug 30 19:52:19 volumio volumio[1138]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 30 19:52:19 volumio volumio[1138]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Aug 30 19:52:19 volumio volumio[1138]: at onErrorNT (internal/child_process.js:472:16) Aug 30 19:52:19 volumio volumio[1138]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Aug 30 19:52:19 volumio volumio[1138]: at runNextTicks (internal/process/task_queues.js:64:3) Aug 30 19:52:19 volumio volumio[1138]: at listOnTimeout (internal/timers.js:526:9) Aug 30 19:52:19 volumio volumio[1138]: at processTimers (internal/timers.js:500:7) { Aug 30 19:52:19 volumio volumio[1138]: errno: -2, Aug 30 19:52:19 volumio volumio[1138]: code: 'ENOENT', Aug 30 19:52:19 volumio volumio[1138]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 19:52:19 volumio volumio[1138]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 19:52:19 volumio volumio[1138]: spawnargs: [ Aug 30 19:52:19 volumio volumio[1138]: '-p', Aug 30 19:52:19 volumio volumio[1138]: 9876, Aug 30 19:52:19 volumio volumio[1138]: '-o', Aug 30 19:52:19 volumio volumio[1138]: '/tmp/camilladsp.log', Aug 30 19:52:19 volumio volumio[1138]: '-l', Aug 30 19:52:19 volumio volumio[1138]: 'warn', Aug 30 19:52:19 volumio volumio[1138]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 30 19:52:19 volumio volumio[1138]: ] Aug 30 19:52:19 volumio volumio[1138]: } Aug 30 19:52:19 volumio volumio[1138]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 19:52:19 volumio sudo[7423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-30 19:51 Aug 30 19:52:19 volumio sudo[7423]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"