-- Logs begin at Wed 2024-08-14 09:45:27 CEST, end at Fri 2024-08-23 07:28:04 CEST. -- Aug 23 07:27:24 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 07:27:24 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 07:27:24 rivo volumio[3431]: info: Discovery: Getting this device information Aug 23 07:27:24 rivo volumio[3431]: info: CoreCommandRouter::volumioGetState Aug 23 07:27:24 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 07:27:24 rivo volumio[3431]: verbose: New Socket.io Connection to 192.168.1.66:3000 from 192.168.1.105 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Aug 23 07:27:24 rivo volumio[3431]: info: CoreCommandRouter::volumioGetState Aug 23 07:27:24 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 23 07:27:24 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 23 07:27:25 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 07:27:25 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 07:27:25 rivo volumio[3431]: info: Discovery: Getting this device information Aug 23 07:27:25 rivo volumio[3431]: info: CoreCommandRouter::volumioGetState Aug 23 07:27:25 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 07:27:29 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 07:27:29 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 07:27:29 rivo volumio[3431]: info: Discovery: Getting this device information Aug 23 07:27:29 rivo volumio[3431]: info: CoreCommandRouter::volumioGetState Aug 23 07:27:29 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 07:27:32 rivo sudo[9643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 23 07:27:32 rivo sudo[9643]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 07:27:32 rivo sudo[9643]: pam_unix(sudo:session): session closed for user root Aug 23 07:27:32 rivo sudo[9647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 23 07:27:32 rivo sudo[9647]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 07:27:32 rivo sudo[9647]: pam_unix(sudo:session): session closed for user root Aug 23 07:27:32 rivo volumio[3431]: verbose: New Socket.io Connection to 192.168.1.66 from 192.168.1.105 UA: Mozilla/5.0 (Linux; Android 14; SM-A525F Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 23 07:27:33 rivo sudo[9651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 23 07:27:33 rivo sudo[9651]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 07:27:33 rivo sudo[9651]: pam_unix(sudo:session): session closed for user root Aug 23 07:27:33 rivo sudo[9655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 23 07:27:33 rivo sudo[9655]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 07:27:33 rivo sudo[9655]: pam_unix(sudo:session): session closed for user root Aug 23 07:27:33 rivo volumio[3431]: verbose: New Socket.io Connection to 192.168.1.66 from 192.168.1.105 UA: Mozilla/5.0 (Linux; Android 14; SM-A525F Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Aug 23 07:27:33 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 23 07:27:33 rivo volumio[3431]: info: CoreCommandRouter::volumioGetVisibleSources Aug 23 07:27:33 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 23 07:27:33 rivo volumio[3431]: info: CoreCommandRouter::volumioGetState Aug 23 07:27:34 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 23 07:27:34 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 23 07:27:34 rivo volumio[3431]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 23 07:27:34 rivo volumio[3431]: info: Received Get System Info Aug 23 07:27:34 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 07:27:34 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 07:27:34 rivo volumio[3431]: info: Discovery: Getting this device information Aug 23 07:27:34 rivo volumio[3431]: info: CoreCommandRouter::volumioGetState Aug 23 07:27:34 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 07:27:34 rivo volumio[3431]: info: CoreCommandRouter::volumioGetState Aug 23 07:27:34 rivo volumio[3431]: info: Listing playlists Aug 23 07:27:34 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 23 07:27:34 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 23 07:27:34 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 23 07:27:34 rivo volumio[3431]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 07:27:35 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 23 07:27:35 rivo volumio[3431]: info: Received Get System Info Aug 23 07:27:35 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 07:27:35 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 07:27:35 rivo volumio[3431]: info: Discovery: Getting this device information Aug 23 07:27:35 rivo volumio[3431]: info: CoreCommandRouter::volumioGetState Aug 23 07:27:35 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 07:27:35 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 23 07:27:36 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 23 07:27:36 rivo volumio[3431]: info: Received Get System Info Aug 23 07:27:36 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 07:27:36 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 07:27:36 rivo volumio[3431]: info: Discovery: Getting this device information Aug 23 07:27:36 rivo volumio[3431]: info: CoreCommandRouter::volumioGetState Aug 23 07:27:36 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 07:27:40 rivo volumio[3431]: info: Retrieving Cloud Streaming UI Aug 23 07:27:40 rivo volumio[3431]: info: Getting Tidal Cloud Configuration Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 07:27:40 rivo volumio[3431]: info: Getting Qobuz Cloud Configuration Aug 23 07:27:40 rivo volumio[3431]: info: Asking plugin for UI Config Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 07:27:40 rivo volumio[3431]: info: Getting Spotify Cloud Configuration Aug 23 07:27:40 rivo volumio[3431]: info: Asking plugin for UI Config Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 07:27:40 rivo volumio[3431]: info: Saving Spotify Acccount Aug 23 07:27:40 rivo volumio[3431]: info: Got it Aug 23 07:27:40 rivo volumio[3431]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 23 07:27:40 rivo volumio[3431]: info: Got Tidal Cloud Configuration Aug 23 07:27:40 rivo volumio[3431]: info: Got it Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::volumioGetBrowseSources Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::volumioGetBrowseSources Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::volumioGetBrowseSources Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 23 07:27:40 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 23 07:27:43 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 23 07:27:44 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 23 07:27:45 rivo volumio[3431]: info: Disabling MyMusic plugin upnp Aug 23 07:27:45 rivo sudo[9659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Aug 23 07:27:45 rivo sudo[9659]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 07:27:45 rivo systemd[1]: Stopping UPnP Renderer front-end to MPD... Aug 23 07:27:45 rivo volumio[3431]: error: Upnp client error: Error: This socket has been ended by the other party Aug 23 07:27:45 rivo volumio[3431]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 23 07:27:48 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 23 07:27:51 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 23 07:27:51 rivo volumio[3431]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 23 07:27:51 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 23 07:27:51 rivo volumio[3431]: info: Received Get System Version Aug 23 07:27:51 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 23 07:27:51 rivo volumio[3431]: info: Received Get System Info Aug 23 07:27:51 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 07:27:51 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 07:27:51 rivo volumio[3431]: info: Discovery: Getting this device information Aug 23 07:27:51 rivo volumio[3431]: info: CoreCommandRouter::volumioGetState Aug 23 07:27:51 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 07:27:52 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 23 07:27:53 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 07:27:53 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 07:27:53 rivo volumio[3431]: info: Discovery: Getting this device information Aug 23 07:27:53 rivo volumio[3431]: info: CoreCommandRouter::volumioGetState Aug 23 07:27:53 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 07:27:56 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 23 07:28:00 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 23 07:28:03 rivo volumio[3431]: info: Enabling MyMusic plugin upnp Aug 23 07:28:03 rivo volumio[3431]: info: Enabling plugin upnp Aug 23 07:28:03 rivo volumio[3431]: info: Loading plugin "upnp"... Aug 23 07:28:03 rivo volumio[3431]: info: [1724390883463] Starting Upmpd Daemon Aug 23 07:28:03 rivo volumio[3431]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 23 07:28:03 rivo volumio[3431]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 23 07:28:03 rivo volumio[3431]: Error: listen EADDRINUSE: address already in use :::6599 Aug 23 07:28:03 rivo volumio[3431]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Aug 23 07:28:03 rivo volumio[3431]: at listenInCluster (net.js:1379:12) Aug 23 07:28:03 rivo volumio[3431]: at Server.listen (net.js:1465:7) Aug 23 07:28:03 rivo volumio[3431]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Aug 23 07:28:03 rivo volumio[3431]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Aug 23 07:28:03 rivo volumio[3431]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Aug 23 07:28:03 rivo volumio[3431]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Aug 23 07:28:03 rivo volumio[3431]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Aug 23 07:28:03 rivo volumio[3431]: code: 'EADDRINUSE', Aug 23 07:28:03 rivo volumio[3431]: errno: -98, Aug 23 07:28:03 rivo volumio[3431]: syscall: 'listen', Aug 23 07:28:03 rivo volumio[3431]: address: '::', Aug 23 07:28:03 rivo volumio[3431]: port: 6599 Aug 23 07:28:03 rivo volumio[3431]: } Aug 23 07:28:03 rivo volumio[3431]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 23 07:28:04 rivo sudo[9671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-23 07:27 Aug 23 07:28:04 rivo sudo[9671]: 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="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 05:06:46 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="420eec03f218d056e8306370042003fc"