-- Logs begin at Thu 2025-03-13 13:31:08 CET, end at Thu 2025-03-13 13:41:23 CET. -- Mar 13 13:40:23 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Mar 13 13:40:24 rivo volumio[3302]: info: handleBrowseUri took 1127 milliseconds Mar 13 13:40:24 rivo volumio[3302]: info: Preload queue cleared Mar 13 13:40:24 rivo volumio[3302]: info: Executing endpoint getSimilarArtists Mar 13 13:40:24 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 13 13:40:24 rivo volumio[3302]: info: Executing endpoint getSimilarArtists Mar 13 13:40:24 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 13 13:40:24 rivo volumio[3302]: info: Executing endpoint getSimilarArtists Mar 13 13:40:24 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 13 13:40:24 rivo volumio[3302]: info: Executing endpoint metavolumio Mar 13 13:40:24 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 13 13:40:24 rivo volumio[3302]: info: Executing endpoint metavolumio Mar 13 13:40:24 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 13 13:40:24 rivo volumio[3302]: info: Executing endpoint metavolumio Mar 13 13:40:24 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 13 13:40:30 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Mar 13 13:40:31 rivo volumio[3302]: info: handleBrowseUri took 402 milliseconds Mar 13 13:40:31 rivo volumio[3302]: info: Preload queue cleared Mar 13 13:40:31 rivo volumio[3302]: info: Preloading song: qobuz://song/103410686 Mar 13 13:40:31 rivo volumio[3302]: info: Exploding uri qobuz://song/103410686 in service qobuz Mar 13 13:40:31 rivo volumio[3302]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 13 13:40:31 rivo volumio[3302]: info: Executing endpoint getSimilarAlbums Mar 13 13:40:31 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Mar 13 13:40:31 rivo volumio[3302]: info: Executing endpoint getSimilarAlbums Mar 13 13:40:31 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Mar 13 13:40:31 rivo volumio[3302]: info: Executing endpoint getSimilarAlbums Mar 13 13:40:31 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Mar 13 13:40:31 rivo volumio[3302]: info: Executing endpoint metavolumio Mar 13 13:40:31 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 13 13:40:31 rivo volumio[3302]: info: Executing endpoint metavolumio Mar 13 13:40:31 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 13 13:40:31 rivo volumio[3302]: info: Executing endpoint metavolumio Mar 13 13:40:31 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 13 13:40:31 rivo volumio[3302]: error: Failed request for metavolumio API Mar 13 13:40:38 rivo volumio[3302]: error: Failed request for metavolumio API Mar 13 13:40:38 rivo volumio[3302]: error: Failed request for metavolumio API Mar 13 13:40:38 rivo volumio[3302]: error: Failed request for metavolumio API Mar 13 13:40:45 rivo volumio[3302]: info: Preload queue cleared Mar 13 13:40:45 rivo volumio[3302]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 13 13:40:45 rivo volumio[3302]: info: CoreStateMachine::ClearQueue Mar 13 13:40:45 rivo volumio[3302]: info: CoreStateMachine::stop Mar 13 13:40:45 rivo volumio[3302]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 13:40:45 rivo volumio[3302]: info: CorePlayQueue::clearPlayQueue Mar 13 13:40:45 rivo volumio[3302]: info: CorePlayQueue::saveQueue Mar 13 13:40:45 rivo volumio[3302]: info: CoreCommandRouter::volumioPushQueue Mar 13 13:40:45 rivo volumio[3302]: info: CoreStateMachine::addQueueItems Mar 13 13:40:45 rivo volumio[3302]: info: CorePlayQueue::addQueueItems Mar 13 13:40:45 rivo volumio[3302]: info: Preload queue cleared Mar 13 13:40:45 rivo volumio[3302]: info: Adding Item to queue: qobuz://album/wxtlflyqfajec Mar 13 13:40:45 rivo volumio[3302]: info: Exploding uri qobuz://album/wxtlflyqfajec in service qobuz Mar 13 13:40:45 rivo volumio[3302]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 13 13:40:50 rivo volumio[3302]: info: explodeUri took 19465 milliseconds Mar 13 13:40:51 rivo volumio[3302]: info: explodeUri took 5998 milliseconds Mar 13 13:40:51 rivo volumio[3302]: info: CoreCommandRouter::volumioPushQueue Mar 13 13:40:51 rivo volumio[3302]: info: CorePlayQueue::saveQueue Mar 13 13:40:51 rivo volumio[3302]: info: CoreStateMachine::updateTrackBlock Mar 13 13:40:51 rivo volumio[3302]: info: CorePlayQueue::getTrackBlock Mar 13 13:40:51 rivo volumio[3302]: info: CoreCommandRouter::volumioPlay Mar 13 13:40:51 rivo volumio[3302]: info: CoreStateMachine::play index 0 Mar 13 13:40:51 rivo volumio[3302]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 13:40:51 rivo volumio[3302]: info: CoreStateMachine::stop Mar 13 13:40:51 rivo volumio[3302]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 13:40:51 rivo volumio[3302]: info: CoreStateMachine::play index undefined Mar 13 13:40:51 rivo volumio[3302]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 13:40:51 rivo volumio[3302]: info: CorePlayQueue::getTrack 0 Mar 13 13:40:51 rivo volumio[3302]: info: CoreStateMachine::startPlaybackTimer Mar 13 13:40:51 rivo volumio[3302]: info: CorePlayQueue::getTrack 0 Mar 13 13:40:51 rivo volumio[3302]: info: CoreCommandRouter::volumioGetVisibleSources Mar 13 13:40:51 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 13 13:40:51 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 13 13:40:51 rivo volumio[3302]: info: [1741869651272] ControllerQobuz::clearAddPlayTrack Mar 13 13:40:51 rivo volumio[3302]: verbose: ControllerMpd::sendMpdCommand stop Mar 13 13:40:51 rivo volumio[3302]: info: sendMpdCommand stop took 6 milliseconds Mar 13 13:40:51 rivo volumio[3302]: verbose: ControllerMpd::sendMpdCommand clear Mar 13 13:40:51 rivo volumio[3302]: info: Mar 13 13:40:51 rivo volumio[3302]: ---------------------------- MPD announces system playlist update Mar 13 13:40:51 rivo volumio[3302]: info: Ignoring MPD Status Update Mar 13 13:40:51 rivo volumio[3302]: info: sendMpdCommand clear took 5 milliseconds Mar 13 13:40:51 rivo volumio[3302]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/103410686" Mar 13 13:40:51 rivo volumio[3302]: error: updateQueue error: null Mar 13 13:40:51 rivo volumio[3302]: info: ------------------------------ 7ms Mar 13 13:40:51 rivo volumio[3302]: error: Upnp client error: Error: This socket has been ended by the other party Mar 13 13:40:51 rivo volumio[3302]: STREAMING PROXY: Handling url /?data=qobuz://song/103410686 Mar 13 13:40:51 rivo volumio[3302]: info: Executing endpoint getStreamUrlqobuz Mar 13 13:40:51 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Mar 13 13:40:58 rivo kernel: [35B blob data] Mar 13 13:40:58 rivo kernel: CFG80211-ERROR) wl_notify_rx_mgmt_frame : TDLS Action Frame Received type = 2 Mar 13 13:40:58 rivo kernel: CFG80211-ERROR) wl_tdls_event_handler : TDLS PEER CONNECTED : 9e:81:aa:f1:09:4b on primary ndev Mar 13 13:41:02 rivo volumio[3302]: info: Preload queue cleared Mar 13 13:41:02 rivo volumio[3302]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 13 13:41:02 rivo volumio[3302]: info: CoreStateMachine::ClearQueue Mar 13 13:41:02 rivo volumio[3302]: info: CoreStateMachine::stop Mar 13 13:41:02 rivo volumio[3302]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 13:41:02 rivo volumio[3302]: info: CorePlayQueue::clearPlayQueue Mar 13 13:41:02 rivo volumio[3302]: info: CorePlayQueue::saveQueue Mar 13 13:41:02 rivo volumio[3302]: info: CoreCommandRouter::volumioPushQueue Mar 13 13:41:02 rivo volumio[3302]: info: CoreStateMachine::addQueueItems Mar 13 13:41:02 rivo volumio[3302]: info: CorePlayQueue::addQueueItems Mar 13 13:41:02 rivo volumio[3302]: info: Preload queue cleared Mar 13 13:41:02 rivo volumio[3302]: info: Adding Item to queue: qobuz://album/wxtlflyqfajec Mar 13 13:41:02 rivo volumio[3302]: info: Using cached record of: qobuz://album/wxtlflyqfajec Mar 13 13:41:02 rivo volumio[3302]: info: CoreCommandRouter::volumioPushQueue Mar 13 13:41:02 rivo volumio[3302]: info: CorePlayQueue::saveQueue Mar 13 13:41:02 rivo volumio[3302]: info: CoreStateMachine::updateTrackBlock Mar 13 13:41:02 rivo volumio[3302]: info: CorePlayQueue::getTrackBlock Mar 13 13:41:02 rivo volumio[3302]: info: CoreCommandRouter::volumioPlay Mar 13 13:41:02 rivo volumio[3302]: info: CoreStateMachine::play index 0 Mar 13 13:41:02 rivo volumio[3302]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 13:41:02 rivo volumio[3302]: info: CoreStateMachine::stop Mar 13 13:41:02 rivo volumio[3302]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 13:41:02 rivo volumio[3302]: info: CoreStateMachine::play index undefined Mar 13 13:41:02 rivo volumio[3302]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 13:41:02 rivo volumio[3302]: info: CorePlayQueue::getTrack 0 Mar 13 13:41:02 rivo volumio[3302]: info: CoreStateMachine::startPlaybackTimer Mar 13 13:41:02 rivo volumio[3302]: info: CorePlayQueue::getTrack 0 Mar 13 13:41:02 rivo volumio[3302]: info: CoreCommandRouter::volumioGetVisibleSources Mar 13 13:41:02 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 13 13:41:02 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 13 13:41:02 rivo volumio[3302]: info: [1741869662054] ControllerQobuz::clearAddPlayTrack Mar 13 13:41:02 rivo volumio[3302]: verbose: ControllerMpd::sendMpdCommand stop Mar 13 13:41:08 rivo volumio[3302]: info: CoreCommandRouter::volumioGetState Mar 13 13:41:08 rivo volumio[3302]: info: CorePlayQueue::getTrack 0 Mar 13 13:41:09 rivo mpd_monitor.sh[2841]: MPD Monitor Service: MPD Appears to be inactive, restarting Mar 13 13:41:09 rivo systemd[1]: Stopping Music Player Daemon... Mar 13 13:41:09 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:10 rivo volumio[3302]: info: Executing endpoint metavolumio Mar 13 13:41:10 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 13 13:41:10 rivo volumio[3302]: info: Executing endpoint metavolumio Mar 13 13:41:10 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 13 13:41:10 rivo volumio[3302]: info: Executing endpoint metavolumio Mar 13 13:41:10 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 13 13:41:10 rivo volumio[3302]: info: CoreCommandRouter::volumioPlay Mar 13 13:41:10 rivo volumio[3302]: info: CoreStateMachine::play index undefined Mar 13 13:41:10 rivo volumio[3302]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 13:41:10 rivo volumio[3302]: info: CorePlayQueue::getTrack 0 Mar 13 13:41:10 rivo volumio[3302]: info: CoreStateMachine::startPlaybackTimer Mar 13 13:41:10 rivo volumio[3302]: info: CorePlayQueue::getTrack 0 Mar 13 13:41:10 rivo volumio[3302]: info: CoreCommandRouter::volumioGetVisibleSources Mar 13 13:41:10 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 13 13:41:10 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 13 13:41:10 rivo volumio[3302]: info: [1741869670177] ControllerQobuz::clearAddPlayTrack Mar 13 13:41:10 rivo volumio[3302]: verbose: ControllerMpd::sendMpdCommand stop Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 13 13:41:15 rivo volumio[3302]: info: Retrieving Cloud Streaming UI Mar 13 13:41:15 rivo volumio[3302]: info: Getting Tidal Cloud Configuration Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 13 13:41:15 rivo volumio[3302]: info: Getting Qobuz Cloud Configuration Mar 13 13:41:15 rivo volumio[3302]: info: Asking plugin for UI Config Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 13 13:41:15 rivo volumio[3302]: info: Getting Spotify Cloud Configuration Mar 13 13:41:15 rivo volumio[3302]: info: Asking plugin for UI Config Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 13 13:41:15 rivo volumio[3302]: info: Saving Spotify Acccount Mar 13 13:41:15 rivo volumio[3302]: info: Got it Mar 13 13:41:15 rivo volumio[3302]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 13 13:41:15 rivo volumio[3302]: info: Got Tidal Cloud Configuration Mar 13 13:41:15 rivo volumio[3302]: info: Got it Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::volumioGetBrowseSources Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::volumioGetBrowseSources Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::volumioGetBrowseSources Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 13 13:41:15 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 13 13:41:16 rivo volumio[3302]: info: Disabling MyMusic plugin bluetooth Mar 13 13:41:16 rivo sudo[5905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service Mar 13 13:41:16 rivo sudo[5905]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:16 rivo systemd[1]: Stopping Volumio Bluetooth Module... Mar 13 13:41:16 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:17 rivo volumiobt[5907]: Killing pulse Mar 13 13:41:17 rivo bluetoothd[3212]: Endpoint unregistered: sender=:1.43 path=/MediaEndpoint/A2DPSource Mar 13 13:41:17 rivo bluetoothd[3212]: Endpoint unregistered: sender=:1.43 path=/MediaEndpoint/A2DPSink Mar 13 13:41:17 rivo volumiobt[5907]: Killing BT Pair agent Mar 13 13:41:17 rivo systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM Mar 13 13:41:17 rivo systemd[1]: volumiobt.service: Succeeded. Mar 13 13:41:17 rivo systemd[1]: Stopped Volumio Bluetooth Module. Mar 13 13:41:17 rivo sudo[5905]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:17 rivo volumio[3302]: info: Volumio BT Module successfully stopped Mar 13 13:41:17 rivo volumio[3302]: info: Disabling plugin bluetooth Mar 13 13:41:17 rivo volumio[3302]: info: Done. Mar 13 13:41:17 rivo volumio[3302]: info: Enabling MyMusic plugin bluetooth Mar 13 13:41:17 rivo volumio[3302]: info: Enabling plugin bluetooth Mar 13 13:41:17 rivo volumio[3302]: info: Loading plugin "bluetooth"... Mar 13 13:41:17 rivo volumio[3302]: info: [1741869677530] Starting BluetoothController Mar 13 13:41:17 rivo volumio[3302]: info: PLUGIN START: bluetooth Mar 13 13:41:17 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 13 13:41:17 rivo volumio[3302]: info: Done. Mar 13 13:41:17 rivo sudo[5913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Rivo Mar 13 13:41:17 rivo sudo[5913]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:17 rivo sudo[5913]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:17 rivo volumio[3302]: info: Bluetooth name changed to Rivo Mar 13 13:41:18 rivo volumio[3302]: info: Disabling MyMusic plugin multiroom Mar 13 13:41:18 rivo volumio[3302]: info: Disabling plugin multiroom Mar 13 13:41:18 rivo volumio[3302]: info: Preparing to generate the ALSA configuration file Mar 13 13:41:18 rivo volumio[3302]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Mar 13 13:41:18 rivo volumio[3302]: info: Reading ALSA contributions from plugins. Mar 13 13:41:18 rivo volumio[3302]: info: Asound.conf file written Mar 13 13:41:18 rivo sudo[5916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 13 13:41:18 rivo sudo[5916]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:18 rivo sudo[5916]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:18 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994 Mar 13 13:41:18 rivo kernel: Err: can not set rate to 4270967296! Mar 13 13:41:18 rivo kernel: Range[3920000 - 500000000] Mar 13 13:41:18 rivo kernel: out of value, fixed it Mar 13 13:41:18 rivo kernel: id=0 set inskew=0 Mar 13 13:41:18 rivo volumio[3302]: No protocol specified Mar 13 13:41:18 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:18 rivo volumio[3302]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Mar 13 13:41:18 rivo volumio[3302]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Mar 13 13:41:18 rivo volumio[3302]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Mar 13 13:41:18 rivo volumio[3302]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Mar 13 13:41:18 rivo volumio[3302]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Topping Internal Clock Validity:0' : Operation not permitted Mar 13 13:41:18 rivo volumio[3302]: info: Output device has changed, restarting MPD Mar 13 13:41:18 rivo sudo[5921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 13 13:41:18 rivo sudo[5921]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:18 rivo volumio[3302]: info: Output device has changed, restarting Shairport Sync Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 13:41:18 rivo sudo[5921]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:18 rivo sudo[5924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 13 13:41:18 rivo sudo[5924]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:18 rivo volumio[3302]: No protocol specified Mar 13 13:41:18 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:18 rivo volumio[3302]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 13 13:41:18 rivo volumio[3302]: No protocol specified Mar 13 13:41:18 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:18 rivo volumio[3302]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo volumio[3302]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo vtcs[4642]: [2025-03-13 13:41:18.659] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Mar 13 13:41:18 rivo vtcs[4642]: [2025-03-13 13:41:18.659] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Mar 13 13:41:18 rivo vtcs[4642]: [2025-03-13 13:41:18.659] [tisoc] [error] [SpkconServer.cpp:473] socket write error. fd=3 errorno=32 error=Broken pipe Mar 13 13:41:18 rivo volumio[3302]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo sudo[5933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 13 13:41:18 rivo sudo[5933]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:18 rivo volumio[3302]: info: Output device has changed, restarting Shairport Sync Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 13:41:18 rivo systemd[1]: Stopping Volumio Tidal Connect Service... Mar 13 13:41:18 rivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Mar 13 13:41:18 rivo systemd[1]: vtcs.service: Succeeded. Mar 13 13:41:18 rivo systemd[1]: Stopped Volumio Tidal Connect Service. Mar 13 13:41:18 rivo sudo[5933]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:18 rivo volumio[3302]: No protocol specified Mar 13 13:41:18 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:18 rivo volumio[3302]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 13 13:41:18 rivo volumio[3302]: No protocol specified Mar 13 13:41:18 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:18 rivo volumio[3302]: info: Done. Mar 13 13:41:18 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:18 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:18 rivo sudo[5943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 13 13:41:18 rivo sudo[5943]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:18 rivo volumio[3302]: info: MPD Permissions set Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo sudo[5943]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 13 13:41:18 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:18 rivo volumio[3302]: info: Starting Shairport Sync Mar 13 13:41:18 rivo volumio[3302]: info: Starting Shairport Sync Mar 13 13:41:19 rivo sudo[5953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 13 13:41:19 rivo sudo[5953]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:19 rivo volumio[3302]: info: Enabling MyMusic plugin multiroom Mar 13 13:41:19 rivo volumio[3302]: info: Enabling plugin multiroom Mar 13 13:41:19 rivo volumio[3302]: info: Loading plugin "multiroom"... Mar 13 13:41:19 rivo volumio[3302]: info: Applying required configuration parameters for plugin multiroom Mar 13 13:41:19 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 13 13:41:19 rivo sudo[5956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 13 13:41:19 rivo sudo[5956]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:19 rivo systemd[1]: shairport-sync.service: Succeeded. Mar 13 13:41:19 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 13 13:41:19 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 13 13:41:19 rivo sudo[5960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Mar 13 13:41:19 rivo sudo[5960]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:19 rivo sudo[5960]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:19 rivo sudo[5953]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:19 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 13 13:41:19 rivo systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Mar 13 13:41:19 rivo systemd[1]: shairport-sync.service: Succeeded. Mar 13 13:41:19 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 13 13:41:19 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 13 13:41:19 rivo sudo[5956]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:19 rivo volumio[3302]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Mar 13 13:41:19 rivo volumio[3302]: info: MRS: MultiRoom plugin initialized Mar 13 13:41:19 rivo volumio[3302]: info: MRS: STOPPING SNAPCLIENT Mar 13 13:41:19 rivo volumio[3302]: info: MRS: Snap server stop Mar 13 13:41:19 rivo sudo[5987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Mar 13 13:41:19 rivo sudo[5987]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:19 rivo volumio[3302]: info: MRS: STOPPING volumioStreaming Mar 13 13:41:19 rivo sudo[5990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Mar 13 13:41:19 rivo sudo[5990]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:19 rivo sudo[5987]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:19 rivo sudo[5990]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:19 rivo sudo[5994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Mar 13 13:41:19 rivo sudo[5994]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:19 rivo volumio[3302]: info: Preparing to generate the ALSA configuration file Mar 13 13:41:19 rivo sudo[5997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 13 13:41:19 rivo sudo[5997]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:19 rivo sudo[5994]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:19 rivo sudo[5997]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 13 13:41:19 rivo volumio[3302]: info: Not Reporting Auto name since its the default one Mar 13 13:41:19 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:19 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 13 13:41:19 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:19 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 13 13:41:19 rivo volumio[3302]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Mar 13 13:41:19 rivo volumio[3302]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 13 13:41:19 rivo volumio[3302]: info: Reading ALSA contributions from plugins. Mar 13 13:41:19 rivo volumio[3302]: info: MRS: Removed streaming files Mar 13 13:41:19 rivo volumio[3302]: info: MRS: volumioStreaming STOPPED Mar 13 13:41:19 rivo volumio[3302]: info: MRS: SNAPSERVER STOPPED Mar 13 13:41:19 rivo volumio[3302]: info: MRS: SNAPCLIENT STOPPED Mar 13 13:41:19 rivo volumio[3302]: info: Shairport-Sync Started Mar 13 13:41:19 rivo volumio[3302]: info: Shairport-Sync Started Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Mar 13 13:41:19 rivo volumio[3302]: No protocol specified Mar 13 13:41:19 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 13 13:41:19 rivo volumio[3302]: info: Asound.conf file written Mar 13 13:41:19 rivo sudo[6007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Mar 13 13:41:19 rivo sudo[6007]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:19 rivo sudo[6007]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:19 rivo sudo[6010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Mar 13 13:41:19 rivo sudo[6011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 13 13:41:19 rivo sudo[6010]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:19 rivo sudo[6011]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:19 rivo sudo[6011]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:19 rivo systemd[1]: Stopping RAAT DAEMON... Mar 13 13:41:19 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Mar 13 13:41:19 rivo systemd[1]: raat-daemon.service: Succeeded. Mar 13 13:41:19 rivo systemd[1]: Stopped RAAT DAEMON. Mar 13 13:41:19 rivo systemd[1]: Started RAAT DAEMON. Mar 13 13:41:19 rivo sudo[6010]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:19 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994 Mar 13 13:41:19 rivo kernel: Err: can not set rate to 4266967296! Mar 13 13:41:19 rivo kernel: Range[3920000 - 500000000] Mar 13 13:41:19 rivo kernel: out of value, fixed it Mar 13 13:41:19 rivo kernel: id=0 set inskew=0 Mar 13 13:41:19 rivo volumio[3302]: No protocol specified Mar 13 13:41:19 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:19 rivo volumio[3302]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Mar 13 13:41:19 rivo volumio[3302]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Mar 13 13:41:19 rivo volumio[3302]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Mar 13 13:41:19 rivo volumio[3302]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Mar 13 13:41:19 rivo volumio[3302]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Topping Internal Clock Validity:0' : Operation not permitted Mar 13 13:41:19 rivo volumio[3302]: info: Output device has changed, restarting MPD Mar 13 13:41:19 rivo volumio[3302]: info: Output device has changed, restarting Shairport Sync Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 13:41:19 rivo sudo[6024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 13 13:41:19 rivo sudo[6024]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:19 rivo sudo[6026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 13 13:41:19 rivo sudo[6026]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:19 rivo sudo[6024]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:19 rivo volumio[3302]: No protocol specified Mar 13 13:41:19 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:19 rivo volumio[3302]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 13 13:41:19 rivo volumio[3302]: No protocol specified Mar 13 13:41:19 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:19 rivo volumio[3302]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:19 rivo volumio[3302]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:19 rivo volumio[3302]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 13 13:41:19 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo sudo[6035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 13 13:41:20 rivo sudo[6035]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:20 rivo volumio[3302]: info: Output device has changed, restarting Shairport Sync Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 13:41:20 rivo sudo[6035]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:20 rivo volumio[3302]: No protocol specified Mar 13 13:41:20 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:20 rivo volumio[3302]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 13 13:41:20 rivo volumio[3302]: No protocol specified Mar 13 13:41:20 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:20 rivo volumio[3302]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: PLUGIN START: multiroom Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Mar 13 13:41:20 rivo volumio[3302]: info: MRS: Pushing multiroomSync output for this device Mar 13 13:41:20 rivo volumio[3302]: info: MRS: Pushing multiroomSync output Mar 13 13:41:20 rivo volumio[3302]: info: Adding audio output: Mar 13 13:41:20 rivo volumio[3302]: error: Can't add: Mar 13 13:41:20 rivo volumio[3302]: info: Adding audio output: Mar 13 13:41:20 rivo volumio[3302]: error: Can't add: Mar 13 13:41:20 rivo volumio[3302]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:20 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 13 13:41:20 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:20 rivo sudo[6051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 13 13:41:20 rivo sudo[6051]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:20 rivo volumio[3302]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 13 13:41:20 rivo volumio[3302]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 13 13:41:20 rivo volumio[3302]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 13 13:41:20 rivo volumio[3302]: info: MPD Permissions set Mar 13 13:41:20 rivo volumio[3302]: info: Raat Daemon started successfully Mar 13 13:41:20 rivo volumio[3302]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo sudo[6051]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: Starting Shairport Sync Mar 13 13:41:20 rivo volumio[3302]: info: Starting Shairport Sync Mar 13 13:41:20 rivo sudo[6061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 13 13:41:20 rivo sudo[6061]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:20 rivo volumio[3302]: info: Preparing to generate the ALSA configuration file Mar 13 13:41:20 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 13 13:41:20 rivo systemd[1]: shairport-sync.service: Succeeded. Mar 13 13:41:20 rivo sudo[6064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 13 13:41:20 rivo sudo[6064]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:20 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 13 13:41:20 rivo volumio[3302]: info: Done. Mar 13 13:41:20 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 13 13:41:20 rivo sudo[6061]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:20 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 13 13:41:20 rivo systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Mar 13 13:41:20 rivo systemd[1]: shairport-sync.service: Succeeded. Mar 13 13:41:20 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 13 13:41:20 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 13 13:41:20 rivo sudo[6064]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: Not Reporting Auto name since its the default one Mar 13 13:41:20 rivo volumio[3302]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Mar 13 13:41:20 rivo volumio[3302]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 13 13:41:20 rivo volumio[3302]: info: Reading ALSA contributions from plugins. Mar 13 13:41:20 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:20 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 13 13:41:20 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:20 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 13 13:41:20 rivo volumio[3302]: info: Shairport-Sync Started Mar 13 13:41:20 rivo volumio[3302]: info: Shairport-Sync Started Mar 13 13:41:20 rivo volumio[3302]: (node:3302) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 13 13:41:20 rivo volumio[3302]: (node:3302) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 13 13:41:20 rivo volumio[3302]: (node:3302) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 13 13:41:20 rivo volumio[3302]: (node:3302) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 13 13:41:20 rivo volumio[3302]: (node:3302) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Mar 13 13:41:20 rivo sudo[6076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Mar 13 13:41:20 rivo sudo[6076]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Mar 13 13:41:20 rivo systemd[1]: Started Volumio Bluetooth Module. Mar 13 13:41:20 rivo sudo[6076]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:20 rivo sudo[6082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Mar 13 13:41:20 rivo sudo[6082]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:20 rivo volumiobt[6079]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Mar 13 13:41:20 rivo sudo[6082]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:20 rivo volumio[3302]: No protocol specified Mar 13 13:41:20 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:20 rivo sudo[6088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Mar 13 13:41:20 rivo sudo[6088]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:20 rivo volumio[3302]: info: Volumio BT Module successfully started Mar 13 13:41:20 rivo volumio[3302]: info: Asound.conf file unchanged, so no further update is needed Mar 13 13:41:20 rivo volumio[3302]: info: Output device has changed, restarting MPD Mar 13 13:41:20 rivo sudo[6088]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:20 rivo sudo[6091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Mar 13 13:41:20 rivo sudo[6091]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:20 rivo sudo[6092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 13 13:41:20 rivo sudo[6092]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:20 rivo volumio[3302]: info: Output device has changed, restarting Shairport Sync Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:20 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 13:41:20 rivo sudo[6092]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:20 rivo systemd[1]: Stopping RAAT DAEMON... Mar 13 13:41:20 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Mar 13 13:41:20 rivo systemd[1]: raat-daemon.service: Succeeded. Mar 13 13:41:20 rivo systemd[1]: Stopped RAAT DAEMON. Mar 13 13:41:20 rivo systemd[1]: Started RAAT DAEMON. Mar 13 13:41:20 rivo sudo[6096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 13 13:41:20 rivo sudo[6091]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:20 rivo sudo[6096]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:22 rivo volumiobt[6079]: pulseaudio: no process found Mar 13 13:41:21 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 13 13:41:21 rivo sudo[6110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 13 13:41:22 rivo volumio[3302]: No protocol specified Mar 13 13:41:22 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:22 rivo volumio[3302]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 13 13:41:22 rivo volumio[3302]: No protocol specified Mar 13 13:41:22 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:22 rivo volumio[3302]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: Output device has changed, restarting Shairport Sync Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: No protocol specified Mar 13 13:41:22 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:22 rivo volumio[3302]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 13 13:41:22 rivo volumio[3302]: No protocol specified Mar 13 13:41:22 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:22 rivo volumio[3302]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: Preparing to generate the ALSA configuration file Mar 13 13:41:22 rivo volumio[3302]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Mar 13 13:41:22 rivo volumio[3302]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 13 13:41:22 rivo volumio[3302]: info: Reading ALSA contributions from plugins. Mar 13 13:41:22 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:22 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 13 13:41:22 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:22 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 13 13:41:22 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:22 rivo volumio[3302]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 13 13:41:22 rivo systemd[1]: shairport-sync.service: Succeeded. Mar 13 13:41:21 rivo sudo[6110]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:22 rivo volumio[3302]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 13 13:41:22 rivo volumio[3302]: info: MPD Permissions set Mar 13 13:41:22 rivo volumio[3302]: info: Raat Daemon started successfully Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: Starting Shairport Sync Mar 13 13:41:22 rivo volumio[3302]: info: Disabling MyMusic plugin upnp Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: Not Reporting Auto name since its the default one Mar 13 13:41:22 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:22 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 13 13:41:21 rivo sudo[6110]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:22 rivo volumio[3302]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 13 13:41:22 rivo volumio[3302]: info: Asound.conf file unchanged, so no further update is needed Mar 13 13:41:22 rivo volumio[3302]: info: Output device has changed, restarting MPD Mar 13 13:41:22 rivo volumio[3302]: info: Output device has changed, restarting Shairport Sync Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: No protocol specified Mar 13 13:41:22 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:22 rivo volumio[3302]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 13 13:41:22 rivo volumio[3302]: No protocol specified Mar 13 13:41:22 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:22 rivo volumio[3302]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: Output device has changed, restarting Shairport Sync Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: No protocol specified Mar 13 13:41:22 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:22 rivo volumio[3302]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 13 13:41:22 rivo volumio[3302]: No protocol specified Mar 13 13:41:22 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:22 rivo volumio[3302]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 13:41:22 rivo volumio[3302]: info: Preparing to generate the ALSA configuration file Mar 13 13:41:22 rivo volumio[3302]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Mar 13 13:41:22 rivo volumio[3302]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 13 13:41:22 rivo volumio[3302]: info: Reading ALSA contributions from plugins. Mar 13 13:41:22 rivo volumio[3302]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 13 13:41:21 rivo sudo[6123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 13 13:41:22 rivo volumio[3302]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 13 13:41:22 rivo volumio[3302]: info: MPD Permissions set Mar 13 13:41:22 rivo volumio[3302]: info: TidalConnect service stoped! Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Mar 13 13:41:22 rivo volumio[3302]: No protocol specified Mar 13 13:41:22 rivo volumio[3302]: xcb_connection_has_error() returned true Mar 13 13:41:22 rivo volumio[3302]: info: Enabling MyMusic plugin upnp Mar 13 13:41:22 rivo volumio[3302]: info: Enabling plugin upnp Mar 13 13:41:22 rivo volumio[3302]: info: Loading plugin "upnp"... Mar 13 13:41:22 rivo volumio[3302]: info: [1741869682235] Starting Upmpd Daemon Mar 13 13:41:22 rivo volumio[3302]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 13 13:41:22 rivo volumio[3302]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 13 13:41:22 rivo volumio[3302]: Error: listen EADDRINUSE: address already in use :::6599 Mar 13 13:41:22 rivo volumio[3302]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Mar 13 13:41:22 rivo volumio[3302]: at listenInCluster (net.js:1379:12) Mar 13 13:41:22 rivo volumio[3302]: at Server.listen (net.js:1465:7) Mar 13 13:41:22 rivo volumio[3302]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Mar 13 13:41:22 rivo volumio[3302]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Mar 13 13:41:22 rivo volumio[3302]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Mar 13 13:41:22 rivo volumio[3302]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Mar 13 13:41:22 rivo volumio[3302]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Mar 13 13:41:22 rivo volumio[3302]: code: 'EADDRINUSE', Mar 13 13:41:22 rivo volumio[3302]: errno: -98, Mar 13 13:41:22 rivo volumio[3302]: syscall: 'listen', Mar 13 13:41:22 rivo volumio[3302]: address: '::', Mar 13 13:41:22 rivo volumio[3302]: port: 6599 Mar 13 13:41:22 rivo volumio[3302]: } Mar 13 13:41:22 rivo volumio[3302]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 13 13:41:21 rivo sudo[6123]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:21 rivo sudo[6123]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:21 rivo sudo[6133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 13 13:41:21 rivo sudo[6133]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:21 rivo sudo[6136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 13 13:41:21 rivo sudo[6136]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:21 rivo sudo[6139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Mar 13 13:41:21 rivo sudo[6139]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:21 rivo sudo[6146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 13 13:41:21 rivo sudo[6146]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:21 rivo sudo[6146]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:21 rivo sudo[6149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 13 13:41:21 rivo sudo[6149]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:21 rivo sudo[6156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Mar 13 13:41:21 rivo sudo[6156]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:21 rivo sudo[6156]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:21 rivo sudo[6160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 13 13:41:21 rivo sudo[6160]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:22 rivo sudo[6173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 13 13:41:22 rivo sudo[6173]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:22 rivo sudo[6183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Mar 13 13:41:22 rivo sudo[6183]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:22 rivo sudo[6183]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:22 rivo systemd[1]: Stopping UPnP Renderer front-end to MPD... Mar 13 13:41:22 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 13 13:41:22 rivo sudo[6197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Mar 13 13:41:22 rivo sudo[6197]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 13:41:22 rivo sudo[6133]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:22 rivo sudo[6136]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:22 rivo sudo[6160]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:22 rivo sudo[6173]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:22 rivo systemd[1]: Stopping RAAT DAEMON... Mar 13 13:41:22 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Mar 13 13:41:22 rivo systemd[1]: raat-daemon.service: Succeeded. Mar 13 13:41:22 rivo systemd[1]: Stopped RAAT DAEMON. Mar 13 13:41:22 rivo systemd[1]: Started RAAT DAEMON. Mar 13 13:41:22 rivo sudo[6197]: pam_unix(sudo:session): session closed for user root Mar 13 13:41:22 rivo pulseaudio[6167]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 13 13:41:22 rivo pulseaudio[6167]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 13 13:41:22 rivo bluetoothd[3212]: Endpoint registered: sender=:1.76 path=/MediaEndpoint/A2DPSource Mar 13 13:41:22 rivo bluetoothd[3212]: Endpoint registered: sender=:1.76 path=/MediaEndpoint/A2DPSink Mar 13 13:41:22 rivo volumiobt[6079]: Applying permissions Mar 13 13:41:22 rivo volumiobt[6079]: Setting BT discoverable and pairable Mar 13 13:41:22 rivo pulseaudio[6167]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Mar 13 13:41:22 rivo volumiobt[6079]: Agent registered Mar 13 13:41:22 rivo volumiobt[6079]: [bluetooth]# -e power on Mar 13 13:41:22 rivo volumiobt[6079]: Invalid command in menu main: -e Mar 13 13:41:22 rivo volumiobt[6079]: Mar 13 13:41:22 rivo volumiobt[6079]: Use "help" for a list of available commands in a menu. Mar 13 13:41:22 rivo volumiobt[6079]: Use "menu " if you want to enter any submenu. Mar 13 13:41:22 rivo volumiobt[6079]: Use "back" if you want to return to menu main. Mar 13 13:41:22 rivo volumiobt[6079]: [bluetooth]# agent on Mar 13 13:41:22 rivo volumiobt[6079]: Agent is already registered Mar 13 13:41:22 rivo volumiobt[6079]: [bluetooth]# discoverable on Mar 13 13:41:22 rivo volumiobt[6079]: [bluetooth]# pairable on Mar 13 13:41:22 rivo volumiobt[6079]: [bluetooth]# agent NoInputNoOutput Mar 13 13:41:22 rivo volumiobt[6079]: Agent is already registered Mar 13 13:41:22 rivo volumiobt[6079]: [bluetooth]# default-agent Mar 13 13:41:22 rivo volumiobt[6079]: [bluetooth]# quit Mar 13 13:41:22 rivo volumiobt[6079]: [59B blob data] Mar 13 13:41:23 rivo sudo[6216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-13 13:40 Mar 13 13:41:23 rivo sudo[6216]: 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="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 12:49:04 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="65eb03fcbe62db7e7fbed9cd39ac44df"