-- Logs begin at Sun 2024-02-18 19:41:55 JST, end at Sat 2024-03-30 13:04:22 JST. -- Mar 30 13:03:00 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:02 rivo volumio[5817]: info: CoreCommandRouter::servicePushState Mar 30 13:03:02 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:02 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:03:02 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:02 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:02 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:04 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:06 rivo volumio[5817]: info: CoreCommandRouter::servicePushState Mar 30 13:03:06 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:06 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:03:06 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:06 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:06 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:08 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:09 rivo volumio[5817]: info: CoreCommandRouter::servicePushState Mar 30 13:03:09 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:09 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:03:09 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:09 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:09 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:12 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:13 rivo volumio[5817]: info: CoreCommandRouter::servicePushState Mar 30 13:03:13 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:13 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:03:13 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:13 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:13 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:15 rivo volumio[5817]: info: CoreCommandRouter::volumioPause Mar 30 13:03:15 rivo volumio[5817]: info: CoreStateMachine::pause Mar 30 13:03:15 rivo volumio[5817]: info: CoreStateMachine::stPlaybackTimer Mar 30 13:03:15 rivo volumio[5817]: info: CoreStateMachine::servicePause Mar 30 13:03:15 rivo volumio[5817]: info: CoreCommandRouter::servicePause Mar 30 13:03:15 rivo volumio[5817]: info: RAAT PAUSE Mar 30 13:03:15 rivo volumio[5817]: info: CoreCommandRouter::servicePushState Mar 30 13:03:15 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:15 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:03:15 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:15 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:15 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:15 rivo volumio[5817]: info: MCU Signalled Playback Inactive Mar 30 13:03:16 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:20 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:21 rivo volumio[5817]: info: CoreCommandRouter::servicePushState Mar 30 13:03:21 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:21 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:21 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:21 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:24 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:28 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:31 rivo volumio[5817]: info: Disabling MyMusic plugin bluetooth Mar 30 13:03:31 rivo sudo[8809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service Mar 30 13:03:31 rivo sudo[8809]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:03:32 rivo systemd[1]: Stopping Volumio Bluetooth Module... Mar 30 13:03:32 rivo volumio[5817]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 30 13:03:32 rivo volumiobt[8811]: Killing pulse Mar 30 13:03:32 rivo volumiobt[8811]: Killing BT Pair agent Mar 30 13:03:32 rivo bluetoothd[5492]: Endpoint unregistered: sender=:1.41 path=/MediaEndpoint/A2DPSource Mar 30 13:03:32 rivo bluetoothd[5492]: Endpoint unregistered: sender=:1.41 path=/MediaEndpoint/A2DPSink Mar 30 13:03:32 rivo systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM Mar 30 13:03:32 rivo systemd[1]: volumiobt.service: Succeeded. Mar 30 13:03:32 rivo systemd[1]: Stopped Volumio Bluetooth Module. Mar 30 13:03:32 rivo sudo[8809]: pam_unix(sudo:session): session closed for user root Mar 30 13:03:32 rivo volumio[5817]: info: Volumio BT Module successfully stopped Mar 30 13:03:32 rivo volumio[5817]: info: Disabling plugin bluetooth Mar 30 13:03:32 rivo volumio[5817]: info: Done. Mar 30 13:03:32 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:36 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:36 rivo volumio[5817]: info: Disabling MyMusic plugin multiroom Mar 30 13:03:36 rivo volumio[5817]: info: Disabling plugin multiroom Mar 30 13:03:36 rivo volumio[5817]: info: Preparing to generate the ALSA configuration file Mar 30 13:03:36 rivo volumio[5817]: info: Asound.conf file written Mar 30 13:03:36 rivo sudo[8816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 30 13:03:36 rivo sudo[8816]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:03:36 rivo sudo[8816]: pam_unix(sudo:session): session closed for user root Mar 30 13:03:36 rivo volumio[5817]: No protocol specified Mar 30 13:03:36 rivo volumio[5817]: xcb_connection_has_error() returned true Mar 30 13:03:36 rivo volumio[5817]: No state is present for card AMLAUGESOUNDMP1 Mar 30 13:03:36 rivo volumio[5817]: Found hardware: "AML-AUGESOUND-M" "" "" "" "" Mar 30 13:03:36 rivo volumio[5817]: Hardware is initialized using a generic method Mar 30 13:03:36 rivo volumio[5817]: No state is present for card AMLAUGESOUNDMP1 Mar 30 13:03:36 rivo volumio[5817]: No state is present for card ITFUSBDAC Mar 30 13:03:36 rivo volumio[5817]: Found hardware: "USB-Audio" "USB Mixer" "USB1d9e:0011" "" "" Mar 30 13:03:36 rivo volumio[5817]: Hardware is initialized using a generic method Mar 30 13:03:36 rivo volumio[5817]: No state is present for card ITFUSBDAC Mar 30 13:03:36 rivo volumio[5817]: info: Output device has changed, restarting MPD Mar 30 13:03:36 rivo sudo[8821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 30 13:03:36 rivo sudo[8821]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:03:36 rivo volumio[5817]: info: Output device has changed, restarting Shairport Sync Mar 30 13:03:36 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 13:03:36 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 30 13:03:36 rivo sudo[8821]: pam_unix(sudo:session): session closed for user root Mar 30 13:03:36 rivo sudo[8823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 30 13:03:36 rivo sudo[8823]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:03:37 rivo systemd[1]: Stopping Music Player Daemon... Mar 30 13:03:37 rivo systemd[1]: mpd.service: Succeeded. Mar 30 13:03:37 rivo volumio[5817]: No protocol specified Mar 30 13:03:37 rivo volumio[5817]: xcb_connection_has_error() returned true Mar 30 13:03:37 rivo volumio[5817]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 30 13:03:37 rivo volumio[5817]: No protocol specified Mar 30 13:03:37 rivo volumio[5817]: xcb_connection_has_error() returned true Mar 30 13:03:37 rivo systemd[1]: Stopped Music Player Daemon. Mar 30 13:03:37 rivo volumio[5817]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 13:03:37 rivo systemd[1]: Starting Music Player Daemon... Mar 30 13:03:37 rivo volumio[5817]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 13:03:37 rivo vtcs[8207]: [2024-03-30 13:03:37.096] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Mar 30 13:03:37 rivo vtcs[8207]: [2024-03-30 13:03:37.097] [tisoc] [error] [SpkconServer.cpp:377] recv error. socket disconnected Mar 30 13:03:37 rivo vtcs[8207]: [2024-03-30 13:03:37.097] [tisoc] [error] [SpkconServer.cpp:474] socket write error. fd=3 errorno=32 error=Broken pipe Mar 30 13:03:37 rivo volumio[5817]: info: Done. Mar 30 13:03:37 rivo sudo[8848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 30 13:03:37 rivo sudo[8848]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:03:37 rivo volumio[5817]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 30 13:03:37 rivo volumio[5817]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 30 13:03:37 rivo volumio[5817]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 30 13:03:37 rivo volumio[5817]: info: MPD Permissions set Mar 30 13:03:37 rivo sudo[8852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 30 13:03:37 rivo sudo[8852]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:03:37 rivo systemd[1]: Stopping Volumio Tidal Connect Service... Mar 30 13:03:37 rivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Mar 30 13:03:37 rivo systemd[1]: vtcs.service: Succeeded. Mar 30 13:03:37 rivo systemd[1]: Stopped Volumio Tidal Connect Service. Mar 30 13:03:37 rivo volumio[5817]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 13:03:37 rivo sudo[8848]: pam_unix(sudo:session): session closed for user root Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 30 13:03:37 rivo sudo[8852]: pam_unix(sudo:session): session closed for user root Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 13:03:37 rivo volumio[5817]: info: Starting Shairport Sync Mar 30 13:03:37 rivo sudo[8886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 30 13:03:37 rivo sudo[8886]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:03:37 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 30 13:03:37 rivo systemd[1]: shairport-sync.service: Succeeded. Mar 30 13:03:37 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 30 13:03:37 rivo volumio[5817]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 30 13:03:37 rivo volumio[5817]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 30 13:03:37 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 30 13:03:37 rivo sudo[8886]: pam_unix(sudo:session): session closed for user root Mar 30 13:03:37 rivo volumio[5817]: info: Shairport-Sync Started Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 30 13:03:37 rivo volumio[5817]: info: Not Reporting Auto name since its the default one Mar 30 13:03:37 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Mar 30 13:03:37 rivo volumio[5817]: No protocol specified Mar 30 13:03:37 rivo volumio[5817]: xcb_connection_has_error() returned true Mar 30 13:03:37 rivo sudo[8930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Mar 30 13:03:37 rivo sudo[8930]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:03:37 rivo sudo[8930]: pam_unix(sudo:session): session closed for user root Mar 30 13:03:37 rivo sudo[8932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Mar 30 13:03:37 rivo sudo[8932]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:03:37 rivo systemd[1]: Stopping RAAT DAEMON... Mar 30 13:03:37 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Mar 30 13:03:37 rivo systemd[1]: raat-daemon.service: Succeeded. Mar 30 13:03:37 rivo volumio[5817]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 30 13:03:37 rivo systemd[1]: Stopped RAAT DAEMON. Mar 30 13:03:37 rivo volumio[5817]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 30 13:03:37 rivo systemd[1]: Started RAAT DAEMON. Mar 30 13:03:37 rivo sudo[8932]: pam_unix(sudo:session): session closed for user root Mar 30 13:03:37 rivo volumio[5817]: info: Raat Daemon started successfully Mar 30 13:03:37 rivo volumio[5817]: info: Executing endpoint restartRAATSocket Mar 30 13:03:38 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Mar 30 13:03:38 rivo volumio[5817]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 10 Mar 30 13:03:38 rivo mpd[8830]: Mar 30 13:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 30 13:03:38 rivo systemd[1]: Started Music Player Daemon. Mar 30 13:03:38 rivo sudo[8823]: pam_unix(sudo:session): session closed for user root Mar 30 13:03:38 rivo volumio[5817]: error: updateQueue error: null Mar 30 13:03:39 rivo volumio[5817]: [VRCP] RAAT stopped playing Mar 30 13:03:39 rivo volumio[5817]: info: CoreCommandRouter::servicePushState Mar 30 13:03:39 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:39 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:03:39 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:39 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:39 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:39 rivo volumio[5817]: info: CorePlayQueue::getTrack 0 Mar 30 13:03:39 rivo volumio[5817]: verbose: STATE SERVICE {"status":"stop","service":"raat","title":"Tannhauser: Overture And Venusberg Music","artist":"Leopold Stokowski - Symphony Of The Air And Chorus","album":"The Sound of Stokowski and Wagner","albumart":"/albumart?web=100/extralarge&path=/tmp/raat/albumart/b830ff9a4f28f76303fddbc28769150e.jpg","uri":"","trackType":"rr","seek":null,"duration":1509,"samplerate":"352.8 kHz","bitdepth":"32 bit","channels":2,"disableUiControls":false,"push_time":1711771401191,"random":false,"repeat":false,"repeatSingle":false,"stream":false,"codec":"","repeatMode":"all"} Mar 30 13:03:39 rivo volumio[5817]: verbose: CURRENT POSITION 0 Mar 30 13:03:39 rivo volumio[5817]: info: CoreStateMachine::syncState stateService stop Mar 30 13:03:39 rivo volumio[5817]: info: CoreStateMachine::syncState currentStatus pause Mar 30 13:03:39 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:39 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:39 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:39 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:39 rivo volumio[5817]: info: CoreCommandRouter::servicePushState Mar 30 13:03:39 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:39 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 13:03:39 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:39 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:39 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:39 rivo volumio[5817]: info: CoreCommandRouter::servicePushState Mar 30 13:03:39 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:39 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:39 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:39 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:40 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:40 rivo volumio[5817]: info: TidalConnect service stoped! Mar 30 13:03:40 rivo volumio[5817]: info: TidalConnect service stoped! Mar 30 13:03:40 rivo volumio[5817]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 30 13:03:40 rivo volumio[5817]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 30 13:03:40 rivo sudo[8983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 30 13:03:40 rivo sudo[8983]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:03:40 rivo systemd[1]: Started Volumio Tidal Connect Service. Mar 30 13:03:40 rivo sudo[8983]: pam_unix(sudo:session): session closed for user root Mar 30 13:03:40 rivo volumio[5817]: info: Executing endpoint tc_getconfig Mar 30 13:03:40 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 30 13:03:40 rivo vtcs[8985]: STARTING TidalConnect services, version: 1.3.0.19 Mar 30 13:03:40 rivo vtcs[8985]: STARTED TidalConnect services. Mar 30 13:03:40 rivo volumio[5817]: info: Executing endpoint tc_connect Mar 30 13:03:40 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 30 13:03:40 rivo volumio[5817]: info: Connecting to TidalConnect Mar 30 13:03:40 rivo volumio[5817]: info: CoreCommandRouter::servicePushState Mar 30 13:03:40 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:40 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:40 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:40 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:40 rivo volumio[5817]: info: CorePlayQueue::getTrack 0 Mar 30 13:03:40 rivo volumio[5817]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Mar 30 13:03:40 rivo volumio[5817]: verbose: CURRENT POSITION 0 Mar 30 13:03:40 rivo volumio[5817]: info: CoreStateMachine::syncState stateService stop Mar 30 13:03:40 rivo volumio[5817]: info: CoreStateMachine::syncState currentStatus pause Mar 30 13:03:40 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:40 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:40 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:40 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:40 rivo volumio[5817]: info: CoreCommandRouter::servicePushState Mar 30 13:03:40 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:40 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:40 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:40 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:40 rivo volumio[5817]: info: CorePlayQueue::getTrack 0 Mar 30 13:03:40 rivo volumio[5817]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Mar 30 13:03:40 rivo volumio[5817]: verbose: CURRENT POSITION 0 Mar 30 13:03:40 rivo volumio[5817]: info: CoreStateMachine::syncState stateService stop Mar 30 13:03:40 rivo volumio[5817]: info: CoreStateMachine::syncState currentStatus pause Mar 30 13:03:40 rivo volumio[5817]: info: CoreStateMachine::pushState Mar 30 13:03:40 rivo volumio[5817]: info: CoreCommandRouter::volumioPushState Mar 30 13:03:41 rivo volumio[5817]: info: MRS: Pushing multiroomSync output update for this device Mar 30 13:03:41 rivo volumio[5817]: info: MRS: Pushing multiroomSync output Mar 30 13:03:43 rivo volumio[5817]: info: TidalConnect service started! Mar 30 13:03:44 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:47 rivo volumio[5817]: info: Disabling MyMusic plugin tidalconnect Mar 30 13:03:47 rivo vtcs[8985]: [2024-03-30 13:03:47.329] [tisoc] [error] [SpkconServer.cpp:377] recv error. socket disconnected Mar 30 13:03:47 rivo vtcs[8985]: [2024-03-30 13:03:47.329] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Mar 30 13:03:47 rivo volumio[5817]: info: Disabling plugin tidalconnect Mar 30 13:03:47 rivo volumio[5817]: info: Done. Mar 30 13:03:47 rivo sudo[9025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 30 13:03:47 rivo sudo[9025]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:03:47 rivo systemd[1]: Stopping Volumio Tidal Connect Service... Mar 30 13:03:47 rivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Mar 30 13:03:47 rivo systemd[1]: vtcs.service: Succeeded. Mar 30 13:03:47 rivo volumio[5817]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 30 13:03:47 rivo systemd[1]: Stopped Volumio Tidal Connect Service. Mar 30 13:03:47 rivo sudo[9025]: pam_unix(sudo:session): session closed for user root Mar 30 13:03:48 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:49 rivo volumio[5817]: info: Disabling MyMusic plugin upnp_browser Mar 30 13:03:49 rivo volumio[5817]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesメディアサーバー Mar 30 13:03:49 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 30 13:03:49 rivo volumio[5817]: info: Disabling plugin upnp_browser Mar 30 13:03:49 rivo volumio[5817]: info: Done. Mar 30 13:03:50 rivo volumio[5817]: info: TidalConnect service stoped! Mar 30 13:03:52 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:03:56 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:04:00 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:04:03 rivo volumio[5817]: info: Disabling MyMusic plugin smart_inputs Mar 30 13:04:03 rivo volumio[5817]: info: Removeing all smart Inputs Mar 30 13:04:03 rivo volumio[5817]: info: Disabling plugin smart_inputs Mar 30 13:04:03 rivo volumio[5817]: info: Done. Mar 30 13:04:04 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:04:07 rivo volumio[5817]: info: Disabling MyMusic plugin cd_controller Mar 30 13:04:07 rivo volumio[5817]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Mar 30 13:04:07 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 30 13:04:07 rivo volumio[5817]: info: Stopping UDEV Watcher for CD Mar 30 13:04:07 rivo volumio[5817]: info: Disabling plugin cd_controller Mar 30 13:04:07 rivo volumio[5817]: info: Done. Mar 30 13:04:08 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:04:10 rivo volumio[5817]: info: Disabling MyMusic plugin airplay_emulation Mar 30 13:04:10 rivo volumio[5817]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Mar 30 13:04:10 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 30 13:04:10 rivo volumio[5817]: info: Disabling plugin airplay_emulation Mar 30 13:04:10 rivo volumio[5817]: info: Done. Mar 30 13:04:10 rivo sudo[9067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Mar 30 13:04:10 rivo sudo[9067]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:04:10 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 30 13:04:10 rivo systemd[1]: shairport-sync.service: Succeeded. Mar 30 13:04:10 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 30 13:04:10 rivo volumio[5817]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 30 13:04:10 rivo sudo[9067]: pam_unix(sudo:session): session closed for user root Mar 30 13:04:10 rivo volumio[5817]: info: Shairport-Sync Stopped Mar 30 13:04:12 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:04:14 rivo volumio[5817]: info: Disabling MyMusic plugin metavolumio Mar 30 13:04:14 rivo volumio[5817]: info: Removing METAVOLUMIO REST API Endpoints Mar 30 13:04:14 rivo volumio[5817]: info: Removing metavolumio REST Endpoint Mar 30 13:04:14 rivo volumio[5817]: info: Removing getSimilarArtists REST Endpoint Mar 30 13:04:14 rivo volumio[5817]: info: Removing getSimilarAlbums REST Endpoint Mar 30 13:04:14 rivo volumio[5817]: info: Removing getSimilarTracks REST Endpoint Mar 30 13:04:14 rivo volumio[5817]: info: Disabling plugin metavolumio Mar 30 13:04:14 rivo volumio[5817]: info: Done. Mar 30 13:04:16 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:04:17 rivo volumio[5817]: info: Disabling MyMusic plugin upnp Mar 30 13:04:17 rivo sudo[9091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Mar 30 13:04:17 rivo sudo[9091]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 13:04:17 rivo systemd[1]: Stopping UPnP Renderer front-end to MPD... Mar 30 13:04:17 rivo volumio[5817]: error: Upnp client error: Error: This socket has been ended by the other party Mar 30 13:04:17 rivo volumio[5817]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 30 13:04:20 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 30 13:04:21 rivo volumio[5817]: info: Enabling MyMusic plugin upnp Mar 30 13:04:21 rivo volumio[5817]: info: Enabling plugin upnp Mar 30 13:04:21 rivo volumio[5817]: info: Loading plugin "upnp"... Mar 30 13:04:21 rivo volumio[5817]: info: [1711771461596] Starting Upmpd Daemon Mar 30 13:04:21 rivo volumio[5817]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 30 13:04:21 rivo volumio[5817]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 30 13:04:21 rivo volumio[5817]: Error: listen EADDRINUSE: address already in use :::6599 Mar 30 13:04:21 rivo volumio[5817]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Mar 30 13:04:21 rivo volumio[5817]: at listenInCluster (net.js:1379:12) Mar 30 13:04:21 rivo volumio[5817]: at Server.listen (net.js:1465:7) Mar 30 13:04:21 rivo volumio[5817]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Mar 30 13:04:21 rivo volumio[5817]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Mar 30 13:04:21 rivo volumio[5817]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Mar 30 13:04:21 rivo volumio[5817]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Mar 30 13:04:21 rivo volumio[5817]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Mar 30 13:04:21 rivo volumio[5817]: code: 'EADDRINUSE', Mar 30 13:04:21 rivo volumio[5817]: errno: -98, Mar 30 13:04:21 rivo volumio[5817]: syscall: 'listen', Mar 30 13:04:21 rivo volumio[5817]: address: '::', Mar 30 13:04:21 rivo volumio[5817]: port: 6599 Mar 30 13:04:21 rivo volumio[5817]: } Mar 30 13:04:21 rivo volumio[5817]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 30 13:04:22 rivo sudo[9102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-30 13:03 Mar 30 13:04:22 rivo sudo[9102]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e831866afe2db61aee9333a8f5ba9d9fd36609c7" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 18 Feb 2024 11:41:55 AM CET" VOLUMIO_VERSION="3.629" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="b0437c7088d6645a661a49f6d9fa596a"