-- Logs begin at Sat 2025-09-13 08:37:54 CEST, end at Sun 2025-09-14 16:31:43 CEST. -- Sep 14 16:30:01 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 14 16:30:03 rivoplus volumio[3124]: info: CoreCommandRouter::volumioVolatilePlay Sep 14 16:30:03 rivoplus volumio[3124]: info: CoreStateMachine::volatilePlay Sep 14 16:30:03 rivoplus volumio[3124]: info: QobuzConnect: Received play Sep 14 16:30:03 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:30:03 rivoplus qobuz-connect[7113]: 20250914 16:30:03.872 [7113.7113] INFO MediaEngine: [0xabca2488]: Resuming playback Sep 14 16:30:08 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 14 16:30:08 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 14 16:30:08 rivoplus volumio[3124]: info: Discovery: Getting this device information Sep 14 16:30:08 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:30:08 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 14 16:30:09 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 14 16:30:09 rivoplus volumio[3124]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 14 16:30:09 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 14 16:30:09 rivoplus volumio[3124]: info: Received Get System Version Sep 14 16:30:09 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 14 16:30:09 rivoplus volumio[3124]: info: Received Get System Info Sep 14 16:30:09 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 14 16:30:09 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 14 16:30:09 rivoplus volumio[3124]: info: Discovery: Getting this device information Sep 14 16:30:09 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:30:09 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 14 16:30:12 rivoplus volumio[3124]: info: CoreCommandRouter::volumioVolatilePlay Sep 14 16:30:12 rivoplus volumio[3124]: info: CoreStateMachine::volatilePlay Sep 14 16:30:12 rivoplus volumio[3124]: info: QobuzConnect: Received play Sep 14 16:30:12 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:30:12 rivoplus qobuz-connect[7113]: 20250914 16:30:12.587 [7113.7113] INFO MediaEngine: [0xabca2488]: Resuming playback Sep 14 16:30:29 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 14 16:30:29 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 14 16:30:29 rivoplus volumio[3124]: info: Discovery: Getting this device information Sep 14 16:30:29 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:30:29 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 14 16:30:33 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetQueue Sep 14 16:30:33 rivoplus volumio[3124]: info: CoreStateMachine::getQueue Sep 14 16:30:33 rivoplus volumio[3124]: info: CorePlayQueue::getQueue Sep 14 16:30:33 rivoplus volumio[3124]: info: Executing endpoint metavolumio Sep 14 16:30:33 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 14 16:30:33 rivoplus volumio[3124]: info: Executing endpoint metavolumio Sep 14 16:30:33 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 14 16:30:35 rivoplus volumio[3124]: error: Failed request for metavolumio API Sep 14 16:30:37 rivoplus volumio[3124]: info: CoreCommandRouter::volumioVolatilePlay Sep 14 16:30:37 rivoplus volumio[3124]: info: CoreStateMachine::volatilePlay Sep 14 16:30:37 rivoplus volumio[3124]: info: QobuzConnect: Received play Sep 14 16:30:37 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:30:37 rivoplus qobuz-connect[7113]: 20250914 16:30:37.147 [7113.7113] INFO MediaEngine: [0xabca2488]: Resuming playback Sep 14 16:30:38 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 14 16:30:38 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 14 16:30:38 rivoplus volumio[3124]: info: Discovery: Getting this device information Sep 14 16:30:38 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:30:38 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 14 16:30:40 rivoplus volumio[3124]: info: CoreCommandRouter::volumioVolatilePlay Sep 14 16:30:40 rivoplus volumio[3124]: info: CoreStateMachine::volatilePlay Sep 14 16:30:40 rivoplus volumio[3124]: info: QobuzConnect: Received play Sep 14 16:30:40 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:30:40 rivoplus qobuz-connect[7113]: 20250914 16:30:40.035 [7113.7113] INFO MediaEngine: [0xabca2488]: Resuming playback Sep 14 16:30:49 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:30:51 rivoplus volumio[3124]: info: Executing endpoint metavolumio Sep 14 16:30:51 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 14 16:30:51 rivoplus volumio[3124]: info: Executing endpoint metavolumio Sep 14 16:30:51 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 14 16:30:51 rivoplus volumio[3124]: info: Executing endpoint metavolumio Sep 14 16:30:51 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 14 16:31:08 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 14 16:31:08 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 14 16:31:08 rivoplus volumio[3124]: info: Discovery: Getting this device information Sep 14 16:31:08 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:31:08 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 14 16:31:19 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:31:21 rivoplus volumio[3124]: info: Executing endpoint metavolumio Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 14 16:31:21 rivoplus volumio[3124]: info: Executing endpoint metavolumio Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 14 16:31:21 rivoplus volumio[3124]: info: Executing endpoint metavolumio Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 14 16:31:21 rivoplus volumio[3124]: No protocol specified Sep 14 16:31:21 rivoplus volumio[3124]: xcb_connection_has_error() returned true Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 14 16:31:21 rivoplus volumio[3124]: No protocol specified Sep 14 16:31:21 rivoplus volumio[3124]: xcb_connection_has_error() returned true Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 16:31:21 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 14 16:31:31 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:31:33 rivoplus volumio[3124]: info: Executing endpoint metavolumio Sep 14 16:31:33 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 14 16:31:33 rivoplus volumio[3124]: info: Executing endpoint metavolumio Sep 14 16:31:33 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 14 16:31:33 rivoplus volumio[3124]: info: Executing endpoint metavolumio Sep 14 16:31:33 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Sep 14 16:31:33 rivoplus volumio[3124]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 14 16:31:33 rivoplus volumio[3124]: info: Retrieving Cloud Streaming UI Sep 14 16:31:33 rivoplus volumio[3124]: info: Getting Tidal Cloud Configuration Sep 14 16:31:33 rivoplus volumio[3124]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 14 16:31:33 rivoplus volumio[3124]: info: Getting Qobuz Cloud Configuration Sep 14 16:31:33 rivoplus volumio[3124]: info: Asking plugin for UI Config Sep 14 16:31:33 rivoplus volumio[3124]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 14 16:31:33 rivoplus volumio[3124]: info: Getting Spotify Cloud Configuration Sep 14 16:31:33 rivoplus volumio[3124]: info: Asking plugin for UI Config Sep 14 16:31:33 rivoplus volumio[3124]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 14 16:31:33 rivoplus volumio[3124]: info: Saving Spotify Acccount Sep 14 16:31:33 rivoplus volumio[3124]: info: Got it Sep 14 16:31:33 rivoplus volumio[3124]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 14 16:31:33 rivoplus volumio[3124]: info: Got Tidal Cloud Configuration Sep 14 16:31:33 rivoplus volumio[3124]: info: Got it Sep 14 16:31:33 rivoplus volumio[3124]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetBrowseSources Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetBrowseSources Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetBrowseSources Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 14 16:31:34 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 14 16:31:37 rivoplus volumio[3124]: info: Disabling MyMusic plugin upnp Sep 14 16:31:37 rivoplus sudo[6674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Sep 14 16:31:37 rivoplus sudo[6674]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 14 16:31:37 rivoplus systemd[1]: Stopping UPnP Renderer front-end to MPD... Sep 14 16:31:37 rivoplus volumio[3124]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 14 16:31:37 rivoplus volumio[3124]: error: Upnp client error: Error: This socket has been ended by the other party Sep 14 16:31:38 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 14 16:31:38 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 14 16:31:38 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 14 16:31:38 rivoplus volumio[3124]: info: Discovery: Getting this device information Sep 14 16:31:38 rivoplus volumio[3124]: info: CoreCommandRouter::volumioGetState Sep 14 16:31:38 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 14 16:31:42 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 14 16:31:42 rivoplus volumio[3124]: info: Enabling MyMusic plugin upnp Sep 14 16:31:42 rivoplus volumio[3124]: info: Enabling plugin upnp Sep 14 16:31:42 rivoplus volumio[3124]: info: Loading plugin "upnp"... Sep 14 16:31:42 rivoplus volumio[3124]: info: [1757860302662] Starting Upmpd Daemon Sep 14 16:31:42 rivoplus volumio[3124]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 14 16:31:42 rivoplus volumio[3124]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 14 16:31:42 rivoplus volumio[3124]: Error: listen EADDRINUSE: address already in use :::6599 Sep 14 16:31:42 rivoplus volumio[3124]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Sep 14 16:31:42 rivoplus volumio[3124]: at listenInCluster (net.js:1379:12) Sep 14 16:31:42 rivoplus volumio[3124]: at Server.listen (net.js:1465:7) Sep 14 16:31:42 rivoplus volumio[3124]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Sep 14 16:31:42 rivoplus volumio[3124]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Sep 14 16:31:42 rivoplus volumio[3124]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Sep 14 16:31:42 rivoplus volumio[3124]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Sep 14 16:31:42 rivoplus volumio[3124]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Sep 14 16:31:42 rivoplus volumio[3124]: code: 'EADDRINUSE', Sep 14 16:31:42 rivoplus volumio[3124]: errno: -98, Sep 14 16:31:42 rivoplus volumio[3124]: syscall: 'listen', Sep 14 16:31:42 rivoplus volumio[3124]: address: '::', Sep 14 16:31:42 rivoplus volumio[3124]: port: 6599 Sep 14 16:31:42 rivoplus volumio[3124]: } Sep 14 16:31:42 rivoplus volumio[3124]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 14 16:31:43 rivoplus sudo[6689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-14 16:30 Sep 14 16:31:43 rivoplus sudo[6689]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:23:19 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="ca35d8983c8e34dfa9cca80071cf9105"