-- 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"