-- Logs begin at Mon 2024-07-22 13:22:29 EDT, end at Sun 2024-09-01 11:56:21 EDT. -- Sep 01 11:55:00 stereo volumio[882]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 01 11:55:00 stereo sudo[2402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Sep 01 11:55:00 stereo sudo[2402]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 11:55:00 stereo sudo[2402]: pam_unix(sudo:session): session closed for user root Sep 01 11:55:00 stereo volumio[882]: xcb_connection_has_error() returned true Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 01 11:55:00 stereo volumio[882]: xcb_connection_has_error() returned true Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 01 11:55:00 stereo volumio[882]: info: VolumeController:: Volume=86 Mute =false Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::volumioGetState Sep 01 11:55:00 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:00 stereo volumio[882]: info: CoreStateMachine::pushState Sep 01 11:55:00 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:00 stereo volumio[882]: info: CoreCommandRouter::volumioPushState Sep 01 11:55:00 stereo volumio[882]: info: MRS: Pushing multiroomSync output update for this device Sep 01 11:55:00 stereo volumio[882]: info: MRS: Pushing multiroomSync output Sep 01 11:55:02 stereo volumio[882]: info: TidalConnect service stoped! Sep 01 11:55:03 stereo volumio[882]: info: TidalConnect service stoped! Sep 01 11:55:03 stereo volumio[882]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Sep 01 11:55:03 stereo volumio[882]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Sep 01 11:55:03 stereo sudo[2420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Sep 01 11:55:03 stereo sudo[2420]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 11:55:03 stereo systemd[1]: Started Volumio Tidal Connect Service. Sep 01 11:55:03 stereo sudo[2420]: pam_unix(sudo:session): session closed for user root Sep 01 11:55:03 stereo volumio[882]: info: Executing endpoint tc_getconfig Sep 01 11:55:03 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Sep 01 11:55:03 stereo vtcs[2422]: STARTING TidalConnect services, version: 1.4.0.34 Sep 01 11:55:03 stereo vtcs[2422]: STARTED TidalConnect services. Sep 01 11:55:03 stereo volumio[882]: info: Executing endpoint tc_connect Sep 01 11:55:03 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Sep 01 11:55:03 stereo volumio[882]: info: Connecting to TidalConnect Sep 01 11:55:03 stereo volumio[882]: info: CoreCommandRouter::servicePushState Sep 01 11:55:03 stereo volumio[882]: info: CoreStateMachine::pushState Sep 01 11:55:03 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:03 stereo volumio[882]: info: CoreCommandRouter::volumioPushState Sep 01 11:55:03 stereo volumio[882]: info: MRS: Pushing multiroomSync output update for this device Sep 01 11:55:03 stereo volumio[882]: info: MRS: Pushing multiroomSync output Sep 01 11:55:03 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:03 stereo volumio[882]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Sep 01 11:55:03 stereo volumio[882]: verbose: CURRENT POSITION 0 Sep 01 11:55:03 stereo volumio[882]: info: CoreStateMachine::syncState stateService stop Sep 01 11:55:03 stereo volumio[882]: info: CoreStateMachine::syncState currentStatus stop Sep 01 11:55:03 stereo volumio[882]: info: CoreStateMachine::pushState Sep 01 11:55:03 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:03 stereo volumio[882]: info: CoreCommandRouter::volumioPushState Sep 01 11:55:03 stereo volumio[882]: info: MRS: Pushing multiroomSync output update for this device Sep 01 11:55:03 stereo volumio[882]: info: MRS: Pushing multiroomSync output Sep 01 11:55:03 stereo volumio[882]: info: No code Sep 01 11:55:03 stereo volumio[882]: info: CoreStateMachine::pushState Sep 01 11:55:03 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:03 stereo volumio[882]: info: CoreCommandRouter::volumioPushState Sep 01 11:55:03 stereo volumio[882]: info: MRS: Pushing multiroomSync output update for this device Sep 01 11:55:03 stereo volumio[882]: info: MRS: Pushing multiroomSync output Sep 01 11:55:03 stereo volumio[882]: info: CoreCommandRouter::servicePushState Sep 01 11:55:03 stereo volumio[882]: info: CoreStateMachine::pushState Sep 01 11:55:03 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:03 stereo volumio[882]: info: CoreCommandRouter::volumioPushState Sep 01 11:55:03 stereo volumio[882]: info: MRS: Pushing multiroomSync output update for this device Sep 01 11:55:03 stereo volumio[882]: info: MRS: Pushing multiroomSync output Sep 01 11:55:03 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:03 stereo volumio[882]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Sep 01 11:55:03 stereo volumio[882]: verbose: CURRENT POSITION 0 Sep 01 11:55:03 stereo volumio[882]: info: CoreStateMachine::syncState stateService stop Sep 01 11:55:03 stereo volumio[882]: info: CoreStateMachine::syncState currentStatus stop Sep 01 11:55:03 stereo volumio[882]: info: CoreStateMachine::pushState Sep 01 11:55:03 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:03 stereo volumio[882]: info: CoreCommandRouter::volumioPushState Sep 01 11:55:03 stereo volumio[882]: info: MRS: Pushing multiroomSync output update for this device Sep 01 11:55:03 stereo volumio[882]: info: MRS: Pushing multiroomSync output Sep 01 11:55:03 stereo volumio[882]: info: No code Sep 01 11:55:03 stereo volumio[882]: info: CoreStateMachine::pushState Sep 01 11:55:03 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:03 stereo volumio[882]: info: CoreCommandRouter::volumioPushState Sep 01 11:55:03 stereo volumio[882]: info: MRS: Pushing multiroomSync output update for this device Sep 01 11:55:03 stereo volumio[882]: info: MRS: Pushing multiroomSync output Sep 01 11:55:04 stereo volumio[882]: info: VolumeController::SetAlsaVolume86 Sep 01 11:55:04 stereo volumio[882]: info: CoreCommandRouter::volumioGetState Sep 01 11:55:04 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:04 stereo volumio[882]: info: CoreStateMachine::pushState Sep 01 11:55:04 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:04 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 11:55:04 stereo volumio[882]: info: CoreCommandRouter::volumioPushState Sep 01 11:55:04 stereo volumio[882]: info: MRS: Pushing multiroomSync output update for this device Sep 01 11:55:04 stereo volumio[882]: info: MRS: Pushing multiroomSync output Sep 01 11:55:06 stereo volumio[882]: info: TidalConnect service started! Sep 01 11:55:09 stereo volumio[882]: info: CoreCommandRouter::volumioGetState Sep 01 11:55:09 stereo volumio[882]: info: CorePlayQueue::getTrack 0 Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 01 11:55:11 stereo volumio[882]: info: Retrieving Cloud Streaming UI Sep 01 11:55:11 stereo volumio[882]: info: Getting Tidal Cloud Configuration Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 01 11:55:11 stereo volumio[882]: info: Getting Qobuz Cloud Configuration Sep 01 11:55:11 stereo volumio[882]: info: Asking plugin for UI Config Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 01 11:55:11 stereo volumio[882]: info: Getting Spotify Cloud Configuration Sep 01 11:55:11 stereo volumio[882]: info: Asking plugin for UI Config Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 01 11:55:11 stereo volumio[882]: info: Saving Spotify Acccount Sep 01 11:55:11 stereo volumio[882]: info: Got it Sep 01 11:55:11 stereo volumio[882]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 01 11:55:11 stereo volumio[882]: info: Got Tidal Cloud Configuration Sep 01 11:55:11 stereo volumio[882]: info: Got it Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::volumioGetBrowseSources Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::volumioGetBrowseSources Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::volumioGetBrowseSources Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:55:11 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 01 11:55:15 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:55:15 stereo volumio[882]: info: Disabling MyMusic plugin upnp Sep 01 11:55:15 stereo sudo[2444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Sep 01 11:55:15 stereo sudo[2444]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 11:55:15 stereo systemd[1]: Stopping UPnP Renderer front-end to MPD... Sep 01 11:55:15 stereo volumio[882]: error: Upnp client error: Error: This socket has been ended by the other party Sep 01 11:55:15 stereo volumio[882]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 01 11:55:19 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:55:23 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:55:27 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:55:31 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:55:35 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:55:39 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:55:43 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:55:47 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:55:51 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:55:55 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:55:59 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:56:03 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:56:07 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:56:11 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:56:15 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:56:19 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 01 11:56:21 stereo volumio[882]: info: Enabling MyMusic plugin upnp Sep 01 11:56:21 stereo volumio[882]: info: Enabling plugin upnp Sep 01 11:56:21 stereo volumio[882]: info: Loading plugin "upnp"... Sep 01 11:56:21 stereo volumio[882]: info: [1725206181506] Starting Upmpd Daemon Sep 01 11:56:21 stereo volumio[882]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 01 11:56:21 stereo volumio[882]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 11:56:21 stereo volumio[882]: Error: listen EADDRINUSE: address already in use :::6599 Sep 01 11:56:21 stereo volumio[882]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Sep 01 11:56:21 stereo volumio[882]: at listenInCluster (net.js:1366:12) Sep 01 11:56:21 stereo volumio[882]: at Server.listen (net.js:1452:7) Sep 01 11:56:21 stereo volumio[882]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Sep 01 11:56:21 stereo volumio[882]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Sep 01 11:56:21 stereo volumio[882]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Sep 01 11:56:21 stereo volumio[882]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Sep 01 11:56:21 stereo volumio[882]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Sep 01 11:56:21 stereo volumio[882]: code: 'EADDRINUSE', Sep 01 11:56:21 stereo volumio[882]: errno: -98, Sep 01 11:56:21 stereo volumio[882]: syscall: 'listen', Sep 01 11:56:21 stereo volumio[882]: address: '::', Sep 01 11:56:21 stereo volumio[882]: port: 6599 Sep 01 11:56:21 stereo volumio[882]: } Sep 01 11:56:21 stereo volumio[882]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 11:56:21 stereo sudo[2499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-01 11:55 Sep 01 11:56:21 stereo sudo[2499]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"