-- Logs begin at Wed 2025-04-23 12:43:01 EDT, end at Wed 2025-04-23 15:23:28 EDT. -- Apr 23 15:22:11 rivoplus go-librespot[3803]: time="2025-04-23T15:22:11-04:00" level=debug msg="fetched chunk 16/30, size: 524288" uri="spotify:track:1lATXTBJDHwawvT1UfxWu3" Apr 23 15:22:13 rivoplus go-librespot[3803]: time="2025-04-23T15:22:13-04:00" level=trace msg="sent dealer ping" Apr 23 15:22:14 rivoplus go-librespot[3803]: time="2025-04-23T15:22:14-04:00" level=trace msg="received dealer pong" Apr 23 15:22:14 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 15:22:14 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 15:22:14 rivoplus volumio[3274]: info: Discovery: Getting this device information Apr 23 15:22:14 rivoplus volumio[3274]: info: CoreCommandRouter::volumioGetState Apr 23 15:22:14 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 15:22:24 rivoplus volumio[3274]: info: CALLMETHOD: audio_interface fusiondsp reseteq Apr 23 15:22:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , reseteq Apr 23 15:22:24 rivoplus go-librespot[3803]: time="2025-04-23T15:22:24-04:00" level=debug msg="fetched chunk 17/30, size: 524288" uri="spotify:track:1lATXTBJDHwawvT1UfxWu3" Apr 23 15:22:24 rivoplus volumio[3274]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 23 15:22:24 rivoplus volumio[3274]: error: FusionDsp - WebSocket error: [object Object] Apr 23 15:22:24 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:22:24 rivoplus volumio[3274]: info: CoreCommandRouter::Close All Modals sent Apr 23 15:22:38 rivoplus go-librespot[3803]: time="2025-04-23T15:22:38-04:00" level=debug msg="fetched chunk 18/30, size: 524288" uri="spotify:track:1lATXTBJDHwawvT1UfxWu3" Apr 23 15:22:43 rivoplus go-librespot[3803]: time="2025-04-23T15:22:43-04:00" level=trace msg="sent dealer ping" Apr 23 15:22:44 rivoplus go-librespot[3803]: time="2025-04-23T15:22:44-04:00" level=trace msg="received dealer pong" Apr 23 15:22:45 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 15:22:45 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 15:22:45 rivoplus volumio[3274]: info: Discovery: Getting this device information Apr 23 15:22:45 rivoplus volumio[3274]: info: CoreCommandRouter::volumioGetState Apr 23 15:22:45 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 15:22:48 rivoplus volumio[3274]: info: CALLMETHOD: audio_interface fusiondsp saveparameq [object Object] Apr 23 15:22:48 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , saveparameq Apr 23 15:22:48 rivoplus volumio[3274]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 23 15:22:48 rivoplus volumio[3274]: error: FusionDsp - WebSocket error: [object Object] Apr 23 15:22:49 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:22:49 rivoplus volumio[3274]: info: CoreCommandRouter::Close All Modals sent Apr 23 15:22:51 rivoplus go-librespot[3803]: time="2025-04-23T15:22:51-04:00" level=debug msg="fetched chunk 19/30, size: 524288" uri="spotify:track:1lATXTBJDHwawvT1UfxWu3" Apr 23 15:22:51 rivoplus volumio[3274]: info: CALLMETHOD: audio_interface fusiondsp reseteq Apr 23 15:22:51 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , reseteq Apr 23 15:22:51 rivoplus kernel: [35B blob data] Apr 23 15:22:51 rivoplus kernel: CFG80211-ERROR) wl_notify_rx_mgmt_frame : TDLS Action Frame Received type = 2 Apr 23 15:22:51 rivoplus kernel: CFG80211-ERROR) wl_tdls_event_handler : TDLS PEER CONNECTED : 56:77:30:f3:f7:d9 on primary ndev Apr 23 15:22:51 rivoplus volumio[3274]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 23 15:22:51 rivoplus volumio[3274]: error: FusionDsp - WebSocket error: [object Object] Apr 23 15:22:51 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:22:51 rivoplus volumio[3274]: info: CoreCommandRouter::Close All Modals sent Apr 23 15:22:57 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 15:22:57 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 15:22:57 rivoplus volumio[3274]: info: Discovery: Getting this device information Apr 23 15:22:57 rivoplus volumio[3274]: info: CoreCommandRouter::volumioGetState Apr 23 15:22:57 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 15:22:57 rivoplus volumio[3274]: info: CALLMETHOD: audio_interface fusiondsp saveparameq [object Object] Apr 23 15:22:57 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , saveparameq Apr 23 15:22:58 rivoplus volumio[3274]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 23 15:22:58 rivoplus volumio[3274]: error: FusionDsp - WebSocket error: [object Object] Apr 23 15:22:58 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:22:58 rivoplus volumio[3274]: info: CoreCommandRouter::Close All Modals sent Apr 23 15:23:03 rivoplus go-librespot[3803]: time="2025-04-23T15:23:03-04:00" level=debug msg="fetched chunk 20/30, size: 524288" uri="spotify:track:1lATXTBJDHwawvT1UfxWu3" Apr 23 15:23:06 rivoplus kernel: CFG80211-ERROR) wl_tdls_event_handler : TDLS PEER DISCONNECTED : 56:77:30:f3:f7:d9 on primary ndev Apr 23 15:23:06 rivoplus kernel: [35B blob data] Apr 23 15:23:06 rivoplus kernel: CFG80211-ERROR) wl_notify_rx_mgmt_frame : TDLS Action Frame Received type = 3 Apr 23 15:23:12 rivoplus go-librespot[3803]: time="2025-04-23T15:23:12-04:00" level=debug msg="fetched chunk 21/30, size: 524288" uri="spotify:track:1lATXTBJDHwawvT1UfxWu3" Apr 23 15:23:13 rivoplus go-librespot[3803]: time="2025-04-23T15:23:13-04:00" level=trace msg="sent dealer ping" Apr 23 15:23:14 rivoplus go-librespot[3803]: time="2025-04-23T15:23:14-04:00" level=trace msg="received dealer pong" Apr 23 15:23:14 rivoplus go-librespot[3803]: time="2025-04-23T15:23:14-04:00" level=trace msg="received accesspoint ping" Apr 23 15:23:14 rivoplus go-librespot[3803]: time="2025-04-23T15:23:14-04:00" level=trace msg="received accesspoint pong ack" Apr 23 15:23:14 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 23 15:23:14 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 23 15:23:14 rivoplus volumio[3274]: info: Discovery: Getting this device information Apr 23 15:23:14 rivoplus volumio[3274]: info: CoreCommandRouter::volumioGetState Apr 23 15:23:14 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 23 15:23:17 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 23 15:23:17 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 23 15:23:17 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:23:17 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:23:17 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:23:17 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:23:17 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:23:19 rivoplus kernel: [35B blob data] Apr 23 15:23:19 rivoplus kernel: CFG80211-ERROR) wl_notify_rx_mgmt_frame : TDLS Action Frame Received type = 2 Apr 23 15:23:19 rivoplus kernel: CFG80211-ERROR) wl_tdls_event_handler : TDLS PEER CONNECTED : 56:77:30:f3:f7:d9 on primary ndev Apr 23 15:23:22 rivoplus go-librespot[3803]: time="2025-04-23T15:23:22-04:00" level=debug msg="fetched chunk 22/30, size: 524288" uri="spotify:track:1lATXTBJDHwawvT1UfxWu3" Apr 23 15:23:24 rivoplus volumio[3274]: info: Enabling plugin fusiondsp Apr 23 15:23:24 rivoplus volumio[3274]: info: Loading plugin "fusiondsp"... Apr 23 15:23:24 rivoplus volumio[3274]: info: Applying required configuration parameters for plugin fusiondsp Apr 23 15:23:24 rivoplus volumio[3274]: info: Preparing to generate the ALSA configuration file Apr 23 15:23:24 rivoplus volumio[3274]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 23 15:23:24 rivoplus volumio[3274]: info: Reading ALSA contributions from plugins. Apr 23 15:23:24 rivoplus volumio[3274]: info: Asound.conf file unchanged, so no further update is needed Apr 23 15:23:24 rivoplus volumio[3274]: info: Output device has changed, restarting MPD Apr 23 15:23:24 rivoplus sudo[11348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 23 15:23:24 rivoplus sudo[11348]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 15:23:24 rivoplus sudo[11348]: pam_unix(sudo:session): session closed for user root Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:23:24 rivoplus volumio[3274]: info: PLUGIN START: fusiondsp Apr 23 15:23:24 rivoplus sudo[11351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 23 15:23:24 rivoplus sudo[11351]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 15:23:24 rivoplus volumio[3274]: info: Loading i18n strings for locale en Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:23:24 rivoplus volumio[3274]: info: FusionDsp - mixtype--------------------- None Apr 23 15:23:24 rivoplus volumio[3274]: info: Preparing to generate the ALSA configuration file Apr 23 15:23:24 rivoplus systemd[1]: Stopping Music Player Daemon... Apr 23 15:23:24 rivoplus volumio[3274]: info: Done. Apr 23 15:23:24 rivoplus volumio[3274]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 23 15:23:24 rivoplus volumio[3274]: info: Reading ALSA contributions from plugins. Apr 23 15:23:24 rivoplus volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 23 15:23:24 rivoplus volumio[3274]: info: MPD Permissions set Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:23:24 rivoplus systemd[1]: mpd.service: Succeeded. Apr 23 15:23:24 rivoplus systemd[1]: Stopped Music Player Daemon. Apr 23 15:23:24 rivoplus systemd[1]: Starting Music Player Daemon... Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 23 15:23:24 rivoplus volumio[3274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 23 15:23:24 rivoplus volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 23 15:23:24 rivoplus volumio[3274]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 23 15:23:24 rivoplus sudo[11354]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 23 15:23:24 rivoplus sudo[11354]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 23 15:23:24 rivoplus sudo[11354]: pam_unix(sudo:session): session closed for user root Apr 23 15:23:27 rivoplus volumio[3274]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 15:23:27 rivoplus volumio[3274]: TypeError: Cannot read property 'off' of undefined Apr 23 15:23:27 rivoplus volumio[3274]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Apr 23 15:23:27 rivoplus volumio[3274]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Apr 23 15:23:27 rivoplus volumio[3274]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Apr 23 15:23:27 rivoplus volumio[3274]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Apr 23 15:23:27 rivoplus volumio[3274]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Apr 23 15:23:27 rivoplus volumio[3274]: at Socket.emit (events.js:400:28) Apr 23 15:23:27 rivoplus volumio[3274]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Apr 23 15:23:27 rivoplus volumio[3274]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Apr 23 15:23:27 rivoplus volumio[3274]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 23 15:23:28 rivoplus mpd[11370]: Apr 23 15:23 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 23 15:23:28 rivoplus systemd[1]: Started Music Player Daemon. Apr 23 15:23:28 rivoplus sudo[11351]: pam_unix(sudo:session): session closed for user root Apr 23 15:23:28 rivoplus sudo[11383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-23 15:22 Apr 23 15:23:28 rivoplus sudo[11383]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:42:11 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="4f5519a96ae5ba7dcfda362cc37343d4"