-- Logs begin at Fri 2025-03-14 18:20:38 CET, end at Fri 2025-03-14 19:04:05 CET. -- Mar 14 19:03:14 rivoplus volumio[3291]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::volumioGetState Mar 14 19:03:14 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:14 rivoplus volumio[3291]: info: Restoring Previous Volume level: 92 false true Mar 14 19:03:14 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume100 Mar 14 19:03:14 rivoplus volumio[3291]: info: Volume configurations have been set Mar 14 19:03:14 rivoplus volumio[3291]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Mar 14 19:03:14 rivoplus vtcs[32495]: [2025-03-14 19:03:14.195] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Mar 14 19:03:14 rivoplus vtcs[32495]: [2025-03-14 19:03:14.196] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Mar 14 19:03:14 rivoplus vtcs[32495]: [2025-03-14 19:03:14.196] [tisoc] [error] [SpkconServer.cpp:473] socket write error. fd=3 errorno=32 error=Broken pipe Mar 14 19:03:14 rivoplus sudo[2997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 14 19:03:14 rivoplus sudo[2997]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 19:03:14 rivoplus systemd[1]: Stopping Volumio Tidal Connect Service... Mar 14 19:03:14 rivoplus systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 14 19:03:14 rivoplus volumio[3291]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Mar 14 19:03:14 rivoplus systemd[1]: vtcs.service: Succeeded. Mar 14 19:03:14 rivoplus systemd[1]: Stopped Volumio Tidal Connect Service. Mar 14 19:03:14 rivoplus sudo[2997]: pam_unix(sudo:session): session closed for user root Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 14 19:03:14 rivoplus volumio[3291]: info: Disabling external Volume Control Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:14 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:14 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:14 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:14 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:14 rivoplus sudo[3013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 14 19:03:14 rivoplus sudo[3013]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 19:03:14 rivoplus sudo[3013]: pam_unix(sudo:session): session closed for user root Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: Not Reporting Auto name since its the default one Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:14 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Mar 14 19:03:14 rivoplus sudo[3027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Mar 14 19:03:14 rivoplus sudo[3027]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 19:03:14 rivoplus sudo[3027]: pam_unix(sudo:session): session closed for user root Mar 14 19:03:15 rivoplus sudo[3029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Mar 14 19:03:15 rivoplus sudo[3029]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 19:03:15 rivoplus systemd[1]: Stopping RAAT DAEMON... Mar 14 19:03:15 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Mar 14 19:03:15 rivoplus systemd[1]: raat-daemon.service: Succeeded. Mar 14 19:03:15 rivoplus systemd[1]: Stopped RAAT DAEMON. Mar 14 19:03:15 rivoplus systemd[1]: Started RAAT DAEMON. Mar 14 19:03:15 rivoplus sudo[3029]: pam_unix(sudo:session): session closed for user root Mar 14 19:03:15 rivoplus volumio[3291]: info: Raat Daemon started successfully Mar 14 19:03:15 rivoplus volumio[3291]: info: Executing endpoint restartRAATSocket Mar 14 19:03:15 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Mar 14 19:03:15 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:15 rivoplus volumio[3291]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Mar 14 19:03:16 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 19:03:16 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 19:03:16 rivoplus volumio[3291]: info: Discovery: Getting this device information Mar 14 19:03:16 rivoplus volumio[3291]: info: CoreCommandRouter::volumioGetState Mar 14 19:03:16 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:16 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 19:03:17 rivoplus volumio[3291]: info: TidalConnect service stoped! Mar 14 19:03:17 rivoplus volumio[3291]: info: TidalConnect service stoped! Mar 14 19:03:17 rivoplus volumio[3291]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 14 19:03:17 rivoplus volumio[3291]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 14 19:03:17 rivoplus sudo[3078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 14 19:03:17 rivoplus sudo[3078]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 19:03:17 rivoplus systemd[1]: Started Volumio Tidal Connect Service. Mar 14 19:03:17 rivoplus sudo[3078]: pam_unix(sudo:session): session closed for user root Mar 14 19:03:17 rivoplus volumio[3291]: info: RAAT: Requesting Headphone Status Mar 14 19:03:17 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Mar 14 19:03:17 rivoplus volumio[3291]: info: MCU Signalled Headphone Mode Disabled Mar 14 19:03:17 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Mar 14 19:03:17 rivoplus volumio[3291]: info: Reporting Headphone State: false Mar 14 19:03:17 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:17 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:17 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:18 rivoplus volumio[3291]: info: Executing endpoint tc_getconfig Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 14 19:03:18 rivoplus vtcs[3080]: STARTING TidalConnect services, version: 1.4.0.34 Mar 14 19:03:18 rivoplus vtcs[3080]: STARTED TidalConnect services. Mar 14 19:03:18 rivoplus volumio[3291]: info: Executing endpoint tc_connect Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 14 19:03:18 rivoplus volumio[3291]: info: Connecting to TidalConnect Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreCommandRouter::servicePushState Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:18 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:18 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:18 rivoplus volumio[3291]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreCommandRouter::servicePushState Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:18 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:18 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:18 rivoplus volumio[3291]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Mar 14 19:03:18 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume- Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:18 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:18 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:18 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:18 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume92 Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:18 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:18 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:18 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:18 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:19 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume- Mar 14 19:03:19 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:19 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:19 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:19 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:19 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:19 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:20 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume+ Mar 14 19:03:20 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:20 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:20 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:20 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:20 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:20 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:20 rivoplus volumio[3291]: info: TidalConnect service started! Mar 14 19:03:25 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume+ Mar 14 19:03:25 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:25 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:25 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:25 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:25 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:25 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:26 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume+ Mar 14 19:03:26 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:26 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:26 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:26 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:26 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:26 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:29 rivoplus ntpd[22998]: receive: Unexpected origin timestamp 0xeb7eedf1.c6a1df7e does not match aorg 0000000000.00000000 from server@45.135.69.197 xmt 0xeb7eedf1.c8b9699a Mar 14 19:03:37 rivoplus volumio[3291]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Mar 14 19:03:37 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Mar 14 19:03:37 rivoplus volumio[3291]: info: CoreCommandRouter::volumioGetState Mar 14 19:03:37 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:37 rivoplus volumio[3291]: info: Restoring Previous Volume level: 100 false true Mar 14 19:03:37 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume100 Mar 14 19:03:37 rivoplus volumio[3291]: info: Volume configurations have been set Mar 14 19:03:37 rivoplus volumio[3291]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Mar 14 19:03:37 rivoplus vtcs[3080]: [2025-03-14 19:03:37.552] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Mar 14 19:03:37 rivoplus vtcs[3080]: [2025-03-14 19:03:37.552] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Mar 14 19:03:37 rivoplus sudo[3150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 14 19:03:37 rivoplus sudo[3150]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 19:03:37 rivoplus systemd[1]: Stopping Volumio Tidal Connect Service... Mar 14 19:03:37 rivoplus systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Mar 14 19:03:37 rivoplus systemd[1]: vtcs.service: Succeeded. Mar 14 19:03:37 rivoplus systemd[1]: Stopped Volumio Tidal Connect Service. Mar 14 19:03:37 rivoplus sudo[3150]: pam_unix(sudo:session): session closed for user root Mar 14 19:03:37 rivoplus volumio[3291]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 14 19:03:37 rivoplus volumio[3291]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 Mar 14 19:03:37 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 14 19:03:37 rivoplus volumio[3291]: info: Disabling external Volume Control Mar 14 19:03:37 rivoplus volumio[3291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 19:03:37 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:37 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:37 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:37 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:37 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:37 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:37 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:37 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:37 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:37 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:37 rivoplus sudo[3164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 14 19:03:37 rivoplus sudo[3164]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 19:03:37 rivoplus sudo[3164]: pam_unix(sudo:session): session closed for user root Mar 14 19:03:37 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: Not Reporting Auto name since its the default one Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Mar 14 19:03:38 rivoplus sudo[3178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Mar 14 19:03:38 rivoplus sudo[3178]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 19:03:38 rivoplus sudo[3178]: pam_unix(sudo:session): session closed for user root Mar 14 19:03:38 rivoplus sudo[3181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Mar 14 19:03:38 rivoplus sudo[3181]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 19:03:38 rivoplus systemd[1]: Stopping RAAT DAEMON... Mar 14 19:03:38 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Mar 14 19:03:38 rivoplus systemd[1]: raat-daemon.service: Succeeded. Mar 14 19:03:38 rivoplus systemd[1]: Stopped RAAT DAEMON. Mar 14 19:03:38 rivoplus systemd[1]: Started RAAT DAEMON. Mar 14 19:03:38 rivoplus sudo[3181]: pam_unix(sudo:session): session closed for user root Mar 14 19:03:38 rivoplus volumio[3291]: info: Raat Daemon started successfully Mar 14 19:03:38 rivoplus volumio[3291]: info: Executing endpoint restartRAATSocket Mar 14 19:03:38 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Mar 14 19:03:38 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:38 rivoplus volumio[3291]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Mar 14 19:03:40 rivoplus volumio[3291]: info: TidalConnect service stoped! Mar 14 19:03:40 rivoplus volumio[3291]: info: TidalConnect service stoped! Mar 14 19:03:41 rivoplus volumio[3291]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 14 19:03:41 rivoplus volumio[3291]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 14 19:03:41 rivoplus sudo[3217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 14 19:03:41 rivoplus sudo[3217]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 19:03:41 rivoplus systemd[1]: Started Volumio Tidal Connect Service. Mar 14 19:03:41 rivoplus sudo[3217]: pam_unix(sudo:session): session closed for user root Mar 14 19:03:41 rivoplus volumio[3291]: info: RAAT: Requesting Headphone Status Mar 14 19:03:41 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Mar 14 19:03:41 rivoplus volumio[3291]: info: MCU Signalled Headphone Mode Disabled Mar 14 19:03:41 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Mar 14 19:03:41 rivoplus volumio[3291]: info: Reporting Headphone State: false Mar 14 19:03:41 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 19:03:41 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:41 rivoplus volumio[3291]: info: Executing endpoint tc_getconfig Mar 14 19:03:41 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 14 19:03:41 rivoplus vtcs[3219]: STARTING TidalConnect services, version: 1.4.0.34 Mar 14 19:03:41 rivoplus vtcs[3219]: STARTED TidalConnect services. Mar 14 19:03:41 rivoplus volumio[3291]: info: Executing endpoint tc_connect Mar 14 19:03:41 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 14 19:03:41 rivoplus volumio[3291]: info: Connecting to TidalConnect Mar 14 19:03:41 rivoplus volumio[3291]: info: CoreCommandRouter::servicePushState Mar 14 19:03:41 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:41 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:41 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:41 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:41 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:41 rivoplus volumio[3291]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Mar 14 19:03:41 rivoplus volumio[3291]: info: CoreCommandRouter::servicePushState Mar 14 19:03:41 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:41 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:41 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:41 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:41 rivoplus volumio[3291]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Mar 14 19:03:42 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume100 Mar 14 19:03:42 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:42 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:42 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:42 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:42 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:42 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:44 rivoplus volumio[3291]: info: TidalConnect service started! Mar 14 19:03:44 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume- Mar 14 19:03:44 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:44 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:44 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:44 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:44 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:44 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:45 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume- Mar 14 19:03:45 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:45 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:45 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:45 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:45 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:45 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:46 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume- Mar 14 19:03:46 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:46 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:46 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:46 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:46 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:46 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:03:46 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 19:03:46 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 19:03:46 rivoplus volumio[3291]: info: Discovery: Getting this device information Mar 14 19:03:46 rivoplus volumio[3291]: info: CoreCommandRouter::volumioGetState Mar 14 19:03:46 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:46 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 19:03:50 rivoplus volumio[3291]: info: VolumeController::SetAlsaVolume+ Mar 14 19:03:50 rivoplus volumio[3291]: info: CoreStateMachine::pushState Mar 14 19:03:50 rivoplus volumio[3291]: info: CorePlayQueue::getTrack 0 Mar 14 19:03:50 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 19:03:50 rivoplus volumio[3291]: info: CoreCommandRouter::volumioPushState Mar 14 19:03:50 rivoplus volumio[3291]: info: Signalling Playback active due to playback status change Mar 14 19:03:50 rivoplus volumio[3291]: info: Updating RAAT Signal Path Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 19:04:01 rivoplus volumio[3291]: info: Retrieving Cloud Streaming UI Mar 14 19:04:01 rivoplus volumio[3291]: info: Getting Tidal Cloud Configuration Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 19:04:01 rivoplus volumio[3291]: info: Getting Qobuz Cloud Configuration Mar 14 19:04:01 rivoplus volumio[3291]: info: Asking plugin for UI Config Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 19:04:01 rivoplus volumio[3291]: info: Getting Spotify Cloud Configuration Mar 14 19:04:01 rivoplus volumio[3291]: info: Asking plugin for UI Config Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 19:04:01 rivoplus volumio[3291]: info: Saving Spotify Acccount Mar 14 19:04:01 rivoplus volumio[3291]: info: Got it Mar 14 19:04:01 rivoplus volumio[3291]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 14 19:04:01 rivoplus volumio[3291]: info: Got Tidal Cloud Configuration Mar 14 19:04:01 rivoplus volumio[3291]: info: Got it Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::volumioGetBrowseSources Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::volumioGetBrowseSources Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::volumioGetBrowseSources Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 14 19:04:01 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 14 19:04:04 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Mar 14 19:04:04 rivoplus volumio[3291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Mar 14 19:04:04 rivoplus volumio[3291]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 14 19:04:04 rivoplus volumio[3291]: Error: getaddrinfo -3007 Mar 14 19:04:04 rivoplus volumio[3291]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Mar 14 19:04:04 rivoplus volumio[3291]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Mar 14 19:04:04 rivoplus volumio[3291]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Mar 14 19:04:04 rivoplus volumio[3291]: code: -3007, Mar 14 19:04:04 rivoplus volumio[3291]: errno: -3007, Mar 14 19:04:04 rivoplus volumio[3291]: syscall: 'getaddrinfo' Mar 14 19:04:04 rivoplus volumio[3291]: } Mar 14 19:04:04 rivoplus volumio[3291]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 14 19:04:05 rivoplus sudo[3320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-14 19:03 Mar 14 19:04:05 rivoplus sudo[3320]: 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="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 12:29:52 PM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="c26baf739f7d1f3fe648e6cf51b2c348"