-- Logs begin at Tue 2024-06-25 11:49:58 CEST, end at Thu 2024-07-11 11:00:49 CEST. -- Jul 11 10:59:10 r-i-v-o volumio[3103]: error: Upnp client error: Error: This socket has been ended by the other party Jul 11 10:59:14 r-i-v-o volumio[3103]: info: Starting UPNP Playback Jul 11 10:59:14 r-i-v-o volumio[3103]: info: Preparing playback through UPNP Jul 11 10:59:14 r-i-v-o volumio[3103]: info: Consume mode Jul 11 10:59:14 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetState Jul 11 10:59:14 r-i-v-o volumio[3103]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 11 10:59:15 r-i-v-o volumio[3103]: info: Clearing queue after UPNP request Jul 11 10:59:15 r-i-v-o volumio[3103]: info: CoreStateMachine::ClearQueue Jul 11 10:59:15 r-i-v-o volumio[3103]: info: CoreStateMachine::stop Jul 11 10:59:15 r-i-v-o volumio[3103]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 10:59:15 r-i-v-o volumio[3103]: info: CorePlayQueue::clearPlayQueue Jul 11 10:59:15 r-i-v-o volumio[3103]: info: CorePlayQueue::saveQueue Jul 11 10:59:15 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioPushState Jul 11 10:59:15 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioPushQueue Jul 11 10:59:15 r-i-v-o volumio[3103]: info: Jul 11 10:59:15 r-i-v-o volumio[3103]: ---------------------------- MPD announces system playlist update Jul 11 10:59:15 r-i-v-o volumio[3103]: info: Ignoring MPD Status Update Jul 11 10:59:15 r-i-v-o volumio[3103]: error: updateQueue error: null Jul 11 10:59:15 r-i-v-o volumio[3103]: info: ------------------------------ 3ms Jul 11 10:59:15 r-i-v-o volumio[3103]: info: Starting UPNP Playback Jul 11 10:59:15 r-i-v-o volumio[3103]: info: Preparing playback through UPNP Jul 11 10:59:15 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetState Jul 11 10:59:15 r-i-v-o volumio[3103]: info: CorePlayQueue::getTrack 0 Jul 11 10:59:15 r-i-v-o volumio[3103]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 11 10:59:34 r-i-v-o volumio[3103]: info: Starting UPNP Playback Jul 11 10:59:34 r-i-v-o volumio[3103]: info: Preparing playback through UPNP Jul 11 10:59:34 r-i-v-o volumio[3103]: info: Consume mode Jul 11 10:59:34 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetState Jul 11 10:59:34 r-i-v-o volumio[3103]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 11 10:59:34 r-i-v-o volumio[3103]: info: Clearing queue after UPNP request Jul 11 10:59:35 r-i-v-o volumio[3103]: info: CoreStateMachine::ClearQueue Jul 11 10:59:35 r-i-v-o volumio[3103]: info: CoreStateMachine::stop Jul 11 10:59:35 r-i-v-o volumio[3103]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 10:59:35 r-i-v-o volumio[3103]: info: CorePlayQueue::clearPlayQueue Jul 11 10:59:35 r-i-v-o volumio[3103]: info: CorePlayQueue::saveQueue Jul 11 10:59:35 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioPushState Jul 11 10:59:35 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioPushQueue Jul 11 10:59:35 r-i-v-o volumio[3103]: info: Jul 11 10:59:35 r-i-v-o volumio[3103]: ---------------------------- MPD announces system playlist update Jul 11 10:59:35 r-i-v-o volumio[3103]: info: Ignoring MPD Status Update Jul 11 10:59:35 r-i-v-o volumio[3103]: error: updateQueue error: null Jul 11 10:59:35 r-i-v-o volumio[3103]: info: ------------------------------ 2ms Jul 11 10:59:35 r-i-v-o volumio[3103]: info: Starting UPNP Playback Jul 11 10:59:35 r-i-v-o volumio[3103]: info: Preparing playback through UPNP Jul 11 10:59:35 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetState Jul 11 10:59:35 r-i-v-o volumio[3103]: info: CorePlayQueue::getTrack 0 Jul 11 10:59:35 r-i-v-o volumio[3103]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 11 10:59:49 r-i-v-o sudo[4329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 11 10:59:49 r-i-v-o sudo[4329]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:59:49 r-i-v-o sudo[4329]: pam_unix(sudo:session): session closed for user root Jul 11 10:59:49 r-i-v-o sudo[4330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 11 10:59:49 r-i-v-o sudo[4330]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:59:49 r-i-v-o sudo[4330]: pam_unix(sudo:session): session closed for user root Jul 11 10:59:49 r-i-v-o volumio[3103]: verbose: New Socket.io Connection to 192.168.1.217 from 192.168.1.175 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:128.0) Gecko/20100101 Firefox/128.0 Engine version: 3 Transport: polling Total Clients: 5 Jul 11 10:59:49 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetState Jul 11 10:59:49 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 11 10:59:49 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetVisibleSources Jul 11 10:59:49 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 11 10:59:49 r-i-v-o volumio[3103]: info: Listing playlists Jul 11 10:59:49 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 11 10:59:49 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 11 10:59:49 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 11 10:59:49 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 11 10:59:51 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 11 10:59:51 r-i-v-o volumio[3103]: info: Received Get System Info Jul 11 10:59:51 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 10:59:51 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 10:59:51 r-i-v-o volumio[3103]: info: Discovery: Getting this device information Jul 11 10:59:51 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetState Jul 11 10:59:51 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 10:59:52 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 11 10:59:52 r-i-v-o volumio[3103]: info: Received Get System Info Jul 11 10:59:52 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 10:59:52 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 10:59:52 r-i-v-o volumio[3103]: info: Discovery: Getting this device information Jul 11 10:59:52 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetState Jul 11 10:59:52 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 10:59:56 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioPlay Jul 11 10:59:56 r-i-v-o volumio[3103]: info: CoreStateMachine::play index undefined Jul 11 10:59:56 r-i-v-o volumio[3103]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 10:59:56 r-i-v-o volumio[3103]: info: CorePlayQueue::getTrack 0 Jul 11 10:59:59 r-i-v-o volumiologrotate[2834]: ls: cannot access '/var/log/samba/log.wb-R': No such file or directory Jul 11 10:59:59 r-i-v-o volumiologrotate[2834]: ls: cannot access 'I': No such file or directory Jul 11 10:59:59 r-i-v-o volumiologrotate[2834]: ls: cannot access 'V': No such file or directory Jul 11 10:59:59 r-i-v-o volumiologrotate[2834]: ls: cannot access 'O': No such file or directory Jul 11 11:00:01 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioPlay Jul 11 11:00:01 r-i-v-o volumio[3103]: info: CoreStateMachine::play index undefined Jul 11 11:00:01 r-i-v-o volumio[3103]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 11:00:01 r-i-v-o volumio[3103]: info: CorePlayQueue::getTrack 0 Jul 11 11:00:07 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 11 11:00:07 r-i-v-o volumio[3103]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 11 11:00:07 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 11 11:00:07 r-i-v-o volumio[3103]: info: Received Get System Version Jul 11 11:00:07 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 11 11:00:07 r-i-v-o volumio[3103]: info: Received Get System Info Jul 11 11:00:07 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 11:00:07 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 11:00:07 r-i-v-o volumio[3103]: info: Discovery: Getting this device information Jul 11 11:00:07 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetState Jul 11 11:00:07 r-i-v-o volumio[3103]: info: CorePlayQueue::getTrack 0 Jul 11 11:00:07 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 11:00:10 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetQueue Jul 11 11:00:10 r-i-v-o volumio[3103]: info: CoreStateMachine::getQueue Jul 11 11:00:10 r-i-v-o volumio[3103]: info: CorePlayQueue::getQueue Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 11:00:18 r-i-v-o volumio[3103]: info: Retrieving Cloud Streaming UI Jul 11 11:00:18 r-i-v-o volumio[3103]: info: Getting Tidal Cloud Configuration Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 11:00:18 r-i-v-o volumio[3103]: info: Getting Qobuz Cloud Configuration Jul 11 11:00:18 r-i-v-o volumio[3103]: info: Asking plugin for UI Config Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 11:00:18 r-i-v-o volumio[3103]: info: Getting Spotify Cloud Configuration Jul 11 11:00:18 r-i-v-o volumio[3103]: info: Asking plugin for UI Config Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 11:00:18 r-i-v-o volumio[3103]: info: Saving Spotify Acccount Jul 11 11:00:18 r-i-v-o volumio[3103]: info: Got it Jul 11 11:00:18 r-i-v-o volumio[3103]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 11 11:00:18 r-i-v-o volumio[3103]: info: Got Tidal Cloud Configuration Jul 11 11:00:18 r-i-v-o volumio[3103]: info: Got it Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetBrowseSources Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetBrowseSources Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::volumioGetBrowseSources Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 11 11:00:18 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 11 11:00:22 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 11 11:00:23 r-i-v-o volumio[3103]: info: Disabling MyMusic plugin upnp Jul 11 11:00:23 r-i-v-o sudo[4385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jul 11 11:00:23 r-i-v-o sudo[4385]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 11:00:23 r-i-v-o volumio[3103]: error: Upnp client error: Error: This socket has been ended by the other party Jul 11 11:00:23 r-i-v-o systemd[1]: Stopping UPnP Renderer front-end to MPD... Jul 11 11:00:26 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 11 11:00:30 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 11 11:00:34 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 11 11:00:38 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 11 11:00:42 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 11 11:00:46 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 11 11:00:48 r-i-v-o volumio[3103]: info: Enabling MyMusic plugin upnp Jul 11 11:00:48 r-i-v-o volumio[3103]: info: Enabling plugin upnp Jul 11 11:00:48 r-i-v-o volumio[3103]: info: Loading plugin "upnp"... Jul 11 11:00:48 r-i-v-o volumio[3103]: info: [1720688448456] Starting Upmpd Daemon Jul 11 11:00:48 r-i-v-o volumio[3103]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 11 11:00:48 r-i-v-o volumio[3103]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 11:00:48 r-i-v-o volumio[3103]: Error: listen EADDRINUSE: address already in use :::6599 Jul 11 11:00:48 r-i-v-o volumio[3103]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Jul 11 11:00:48 r-i-v-o volumio[3103]: at listenInCluster (net.js:1379:12) Jul 11 11:00:48 r-i-v-o volumio[3103]: at Server.listen (net.js:1465:7) Jul 11 11:00:48 r-i-v-o volumio[3103]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jul 11 11:00:48 r-i-v-o volumio[3103]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jul 11 11:00:48 r-i-v-o volumio[3103]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jul 11 11:00:48 r-i-v-o volumio[3103]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 11 11:00:48 r-i-v-o volumio[3103]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Jul 11 11:00:48 r-i-v-o volumio[3103]: code: 'EADDRINUSE', Jul 11 11:00:48 r-i-v-o volumio[3103]: errno: -98, Jul 11 11:00:48 r-i-v-o volumio[3103]: syscall: 'listen', Jul 11 11:00:48 r-i-v-o volumio[3103]: address: '::', Jul 11 11:00:48 r-i-v-o volumio[3103]: port: 6599 Jul 11 11:00:48 r-i-v-o volumio[3103]: } Jul 11 11:00:48 r-i-v-o volumio[3103]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 11:00:49 r-i-v-o sudo[4398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-11 10:59 Jul 11 11:00:49 r-i-v-o sudo[4398]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:27:25 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="891b8adfc94c7cc44424972b60e8e09c"