-- Logs begin at Thu 2025-07-03 19:27:31 IDT, end at Thu 2025-07-10 20:03:12 IDT. --
Jul 10 20:02:00 rivoplus sudo[4718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Jul 10 20:02:00 rivoplus sudo[4718]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:00 rivoplus volumio[3292]: No protocol specified
Jul 10 20:02:00 rivoplus volumio[3292]: xcb_connection_has_error() returned true
Jul 10 20:02:00 rivoplus systemd[1]: Stopping RAAT DAEMON...
Jul 10 20:02:00 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
Jul 10 20:02:00 rivoplus systemd[1]: raat-daemon.service: Succeeded.
Jul 10 20:02:00 rivoplus systemd[1]: Stopped RAAT DAEMON.
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:00 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:00 rivoplus systemd[1]: Started RAAT DAEMON.
Jul 10 20:02:00 rivoplus sudo[4718]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:00 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 10 20:02:00 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 10 20:02:00 rivoplus sudo[4721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
Jul 10 20:02:00 rivoplus sudo[4721]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:00 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus sudo[4721]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:00 rivoplus volumio[3292]: info: Raat Daemon started successfully
Jul 10 20:02:00 rivoplus sudo[4728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Jul 10 20:02:00 rivoplus sudo[4728]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:00 rivoplus volumio[3292]: info: Asound.conf file unchanged, so no further update is needed
Jul 10 20:02:00 rivoplus volumio[3292]: info: Output device has changed, restarting MPD
Jul 10 20:02:00 rivoplus systemd[1]: Stopping RAAT DAEMON...
Jul 10 20:02:00 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
Jul 10 20:02:00 rivoplus systemd[1]: raat-daemon.service: Succeeded.
Jul 10 20:02:00 rivoplus systemd[1]: Stopped RAAT DAEMON.
Jul 10 20:02:00 rivoplus systemd[1]: Started RAAT DAEMON.
Jul 10 20:02:00 rivoplus sudo[4728]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:00 rivoplus sudo[4736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 10 20:02:00 rivoplus sudo[4736]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:00 rivoplus volumio[3292]: info: Output device has changed, restarting Shairport Sync
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus sudo[4736]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 10 20:02:00 rivoplus sudo[4744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 10 20:02:00 rivoplus sudo[4744]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:00 rivoplus systemd[1]: Stopping Music Player Daemon...
Jul 10 20:02:00 rivoplus volumio[3292]: No protocol specified
Jul 10 20:02:00 rivoplus volumio[3292]: xcb_connection_has_error() returned true
Jul 10 20:02:00 rivoplus volumio[3292]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 10 20:02:00 rivoplus volumio[3292]: No protocol specified
Jul 10 20:02:00 rivoplus volumio[3292]: xcb_connection_has_error() returned true
Jul 10 20:02:00 rivoplus volumio[3292]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jul 10 20:02:00 rivoplus systemd[1]: mpd.service: Succeeded.
Jul 10 20:02:00 rivoplus systemd[1]: Stopped Music Player Daemon.
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus systemd[1]: Starting Music Player Daemon...
Jul 10 20:02:00 rivoplus volumio[3292]: info: QobuzConnect: setDeactiveState invoked
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:00 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:00 rivoplus volumio[3292]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus sudo[4760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jul 10 20:02:00 rivoplus sudo[4760]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:00 rivoplus sudo[4760]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:00 rivoplus sudo[4764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jul 10 20:02:00 rivoplus sudo[4764]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:00 rivoplus sudo[4756]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 10 20:02:00 rivoplus sudo[4756]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:00 rivoplus sudo[4756]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:00 rivoplus sudo[4764]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:00 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 10 20:02:00 rivoplus sudo[4772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jul 10 20:02:00 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 10 20:02:00 rivoplus sudo[4772]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:00 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 10 20:02:00 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 10 20:02:00 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 10 20:02:00 rivoplus sudo[4772]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:00 rivoplus volumio[3292]: info: MPD Permissions set
Jul 10 20:02:00 rivoplus volumio[3292]: info: Raat Daemon started successfully
Jul 10 20:02:00 rivoplus volumio[3292]: info: Executing endpoint restartRAATSocket
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jul 10 20:02:00 rivoplus sudo[4776]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jul 10 20:02:00 rivoplus sudo[4776]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:00 rivoplus qobuz-connect[4697]: 20250710 20:02:00.674 [4697.4697] INFO SampleApp: Stopping Local configuration server
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus systemd[1]: Stopping Volumio Qobuz Connect Service...
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus qobuz-connect[4697]: 20250710 20:02:00.684 [4697.4697] INFO SampleApp: shat down connection on UNIX socket
Jul 10 20:02:00 rivoplus systemd[1]: qobuz-connect.service: Succeeded.
Jul 10 20:02:00 rivoplus systemd[1]: Stopped Volumio Qobuz Connect Service.
Jul 10 20:02:00 rivoplus systemd[1]: Started Volumio Qobuz Connect Service.
Jul 10 20:02:00 rivoplus sudo[4776]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:00 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 10 20:02:00 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 10 20:02:00 rivoplus volumio[3292]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Jul 10 20:02:00 rivoplus volumio[3292]: info: QobuzConnect: setDeactiveState invoked
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:00 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:00 rivoplus volumio[3292]: info: Executing endpoint qc_getconfig
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jul 10 20:02:00 rivoplus qobuz-connect[4780]: 20250710 20:02:00.823 [4780.4780] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jul 10 20:02:00 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:00 rivoplus volumio[3292]: info: Starting Shairport Sync
Jul 10 20:02:00 rivoplus qobuz-connect[4780]: 20250710 20:02:00.830 [4780.4780] INFO VolumeManager: [0xac2df830]: Setting new playback volume: 75
Jul 10 20:02:00 rivoplus qobuz-connect[4780]: 20250710 20:02:00.830 [4780.4780] INFO VolumeManager: [0xac2df830]: Setting new mute state: 0
Jul 10 20:02:00 rivoplus qobuz-connect[4780]: 20250710 20:02:00.830 [4780.4780] INFO QobuzConnect: [0xac2e0200]: Client initialized!
Jul 10 20:02:00 rivoplus qobuz-connect[4780]: 20250710 20:02:00.830 [4780.4780] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp
Jul 10 20:02:00 rivoplus qobuz-connect[4780]: 20250710 20:02:00.845 [4780.4780] INFO LocalConfigManager: [0xac2df110]: Starting Local Configuration server
Jul 10 20:02:00 rivoplus qobuz-connect[4780]: 20250710 20:02:00.845 [4780.4780] INFO SampleApp: Starting Local configuration server
Jul 10 20:02:00 rivoplus qobuz-connect[4780]: 20250710 20:02:00.846 [4780.4780] INFO SampleApp: Connected to UNIX socket client 0xac2d4ed8
Jul 10 20:02:00 rivoplus volumio[3292]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Jul 10 20:02:00 rivoplus volumio[3292]: info: QobuzConnect: QOBUZ Connect daemon connected
Jul 10 20:02:00 rivoplus sudo[4789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 10 20:02:00 rivoplus sudo[4789]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:00 rivoplus systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 10 20:02:00 rivoplus systemd[1]: shairport-sync.service: Succeeded.
Jul 10 20:02:00 rivoplus systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 10 20:02:00 rivoplus systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 10 20:02:00 rivoplus sudo[4789]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 10 20:02:00 rivoplus volumio[3292]: info: Not Reporting Auto name since its the default one
Jul 10 20:02:00 rivoplus qobuz-connect[4780]: 20250710 20:02:00.973 [4780.4780] INFO SampleApp: Playback volume changed: 75
Jul 10 20:02:00 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 10 20:02:00 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 10 20:02:01 rivoplus volumio[3292]: info: Shairport-Sync Started
Jul 10 20:02:01 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:01 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:01 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Jul 10 20:02:01 rivoplus volumio[3292]: No protocol specified
Jul 10 20:02:01 rivoplus volumio[3292]: xcb_connection_has_error() returned true
Jul 10 20:02:01 rivoplus sudo[4803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
Jul 10 20:02:01 rivoplus sudo[4803]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:01 rivoplus sudo[4803]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:01 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:01 rivoplus sudo[4805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Jul 10 20:02:01 rivoplus sudo[4805]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:01 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:01 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:01 rivoplus systemd[1]: Stopping RAAT DAEMON...
Jul 10 20:02:01 rivoplus systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
Jul 10 20:02:01 rivoplus systemd[1]: raat-daemon.service: Succeeded.
Jul 10 20:02:01 rivoplus systemd[1]: Stopped RAAT DAEMON.
Jul 10 20:02:01 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 10 20:02:01 rivoplus volumio[3292]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 10 20:02:01 rivoplus systemd[1]: Started RAAT DAEMON.
Jul 10 20:02:01 rivoplus sudo[4805]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:01 rivoplus volumio[3292]: info: Raat Daemon started successfully
Jul 10 20:02:01 rivoplus volumio[3292]: info: Executing endpoint restartRAATSocket
Jul 10 20:02:01 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jul 10 20:02:01 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:01 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:01 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:01 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:01 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:02 rivoplus volumio[3292]: info: TidalConnect service stoped!
Jul 10 20:02:02 rivoplus volumio[3292]: info: TidalConnect service stoped!
Jul 10 20:02:02 rivoplus volumio[3292]: info: TidalConnect service stoped!
Jul 10 20:02:02 rivoplus volumio[3292]: info: TidalConnect service stoped!
Jul 10 20:02:02 rivoplus volumio[3292]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Jul 10 20:02:02 rivoplus volumio[3292]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Jul 10 20:02:02 rivoplus sudo[4832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Jul 10 20:02:02 rivoplus sudo[4832]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:02 rivoplus systemd[1]: Started Volumio Tidal Connect Service.
Jul 10 20:02:02 rivoplus volumio[3292]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Jul 10 20:02:02 rivoplus volumio[3292]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Jul 10 20:02:02 rivoplus sudo[4832]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:02 rivoplus mpd[4773]: Jul 10 20:02 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 10 20:02:02 rivoplus systemd[1]: Started Music Player Daemon.
Jul 10 20:02:02 rivoplus sudo[4744]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:02 rivoplus sudo[4844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Jul 10 20:02:02 rivoplus sudo[4844]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:02 rivoplus volumio[3292]: error: updateQueue error: null
Jul 10 20:02:02 rivoplus sudo[4844]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:02 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:02 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:02 rivoplus volumio[3292]: info: Executing endpoint tc_getconfig
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Jul 10 20:02:02 rivoplus vtcs[4838]: STARTING TidalConnect services, version: 1.5.1-beta1
Jul 10 20:02:02 rivoplus vtcs[4838]: STARTED TidalConnect services.
Jul 10 20:02:02 rivoplus volumio[3292]: info: Executing endpoint tc_connect
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Jul 10 20:02:02 rivoplus volumio[3292]: info: Connecting to TidalConnect
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreStateMachine::pushState
Jul 10 20:02:02 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:02 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:02 rivoplus volumio[3292]: info: MRS: Pushing multiroomSync output update for this device
Jul 10 20:02:02 rivoplus volumio[3292]: info: MRS: Pushing multiroomSync output
Jul 10 20:02:02 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:02 rivoplus volumio[3292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::servicePushState
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreStateMachine::pushState
Jul 10 20:02:02 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:02 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:02 rivoplus volumio[3292]: info: MRS: Pushing multiroomSync output update for this device
Jul 10 20:02:02 rivoplus volumio[3292]: info: MRS: Pushing multiroomSync output
Jul 10 20:02:02 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:02 rivoplus volumio[3292]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect
Jul 10 20:02:02 rivoplus volumio[3292]: info: Updating RAAT Signal Path
Jul 10 20:02:02 rivoplus volumio[3292]: info: Updating RAAT Signal Path
Jul 10 20:02:02 rivoplus volumio[3292]: info: RAAT: Requesting Headphone Status
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus
Jul 10 20:02:02 rivoplus volumio[3292]: info: MCU Signalled Headphone Mode Disabled
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState
Jul 10 20:02:02 rivoplus volumio[3292]: info: Reporting Headphone State: false
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:02 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:02 rivoplus volumio[3292]: info: Updating RAAT Signal Path
Jul 10 20:02:03 rivoplus volumio[3292]: info: RAAT: Requesting Headphone Status
Jul 10 20:02:03 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus
Jul 10 20:02:03 rivoplus volumio[3292]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Jul 10 20:02:03 rivoplus volumio[3292]: info: CoreStateMachine::getcurrentVolume
Jul 10 20:02:03 rivoplus volumio[3292]: info: CoreCommandRouter::volumioRetrievevolume
Jul 10 20:02:03 rivoplus volumio[3292]: info: CoreStateMachine::pushState
Jul 10 20:02:03 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:03 rivoplus volumio[3292]: info: CoreCommandRouter::volumioPushState
Jul 10 20:02:03 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:03 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:03 rivoplus volumio[3292]: info: MRS: Pushing multiroomSync output update for this device
Jul 10 20:02:03 rivoplus volumio[3292]: info: MRS: Pushing multiroomSync output
Jul 10 20:02:03 rivoplus volumio[3292]: info: Updating RAAT Signal Path
Jul 10 20:02:03 rivoplus volumio[3292]: info: MCU Signalled Headphone Mode Disabled
Jul 10 20:02:03 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState
Jul 10 20:02:03 rivoplus volumio[3292]: info: Reporting Headphone State: false
Jul 10 20:02:03 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:03 rivoplus volumio[3292]: info: Updating RAAT Signal Path
Jul 10 20:02:03 rivoplus volumio[3292]: info: TidalConnect service stoped!
Jul 10 20:02:03 rivoplus volumio[3292]: info: TidalConnect service stoped!
Jul 10 20:02:03 rivoplus volumio[3292]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Jul 10 20:02:03 rivoplus volumio[3292]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Jul 10 20:02:03 rivoplus sudo[4889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Jul 10 20:02:03 rivoplus sudo[4889]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 20:02:03 rivoplus sudo[4889]: pam_unix(sudo:session): session closed for user root
Jul 10 20:02:03 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:03 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:03 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:03 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 10 20:02:03 rivoplus volumio[3292]: error: error
Jul 10 20:02:04 rivoplus volumio[3292]: info: RAAT: Requesting Headphone Status
Jul 10 20:02:04 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus
Jul 10 20:02:04 rivoplus volumio[3292]: info: MCU Signalled Headphone Mode Disabled
Jul 10 20:02:04 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState
Jul 10 20:02:04 rivoplus volumio[3292]: info: Reporting Headphone State: false
Jul 10 20:02:04 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:04 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 20:02:04 rivoplus volumio[3292]: info: Updating RAAT Signal Path
Jul 10 20:02:04 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:04 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:04 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:05 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:05 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:05 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:05 rivoplus volumio[3292]: info: TidalConnect service started!
Jul 10 20:02:05 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetQueue
Jul 10 20:02:05 rivoplus volumio[3292]: info: CoreStateMachine::getQueue
Jul 10 20:02:05 rivoplus volumio[3292]: info: CorePlayQueue::getQueue
Jul 10 20:02:05 rivoplus volumio[3292]: info: TidalConnect service started!
Jul 10 20:02:06 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:06 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:06 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:06 rivoplus volumio[3292]: info: TidalConnect service started!
Jul 10 20:02:07 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:07 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:07 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:08 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:08 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:08 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:09 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:09 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:09 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:10 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:10 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:10 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:11 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:11 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:11 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:12 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 10 20:02:12 rivoplus volumio[3292]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jul 10 20:02:12 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jul 10 20:02:12 rivoplus volumio[3292]: info: Received Get System Version
Jul 10 20:02:12 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 10 20:02:12 rivoplus volumio[3292]: info: Received Get System Info
Jul 10 20:02:12 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 10 20:02:12 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 10 20:02:12 rivoplus volumio[3292]: info: Discovery: Getting this device information
Jul 10 20:02:12 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:12 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:12 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 10 20:02:12 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:12 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:12 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:13 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:13 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:13 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:15 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:15 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:15 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:16 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 10 20:02:16 rivoplus volumio[3292]: info: Preload queue cleared
Jul 10 20:02:16 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:16 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:16 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:17 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 10 20:02:17 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 10 20:02:17 rivoplus volumio[3292]: info: Discovery: Getting this device information
Jul 10 20:02:17 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:17 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:17 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 10 20:02:17 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:17 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:17 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:18 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 10 20:02:18 rivoplus volumio[3292]: info: Preload queue cleared
Jul 10 20:02:18 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:18 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:18 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:20 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:20 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:20 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:21 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:21 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:21 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:21 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 10 20:02:21 rivoplus volumio[3292]: info: Preload queue cleared
Jul 10 20:02:22 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jul 10 20:02:22 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:22 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:23 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:23 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:23 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:24 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:24 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:24 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:24 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:24 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:24 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:24 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 10 20:02:25 rivoplus volumio[3292]: info: Preload queue cleared
Jul 10 20:02:25 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:25 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:25 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:26 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:26 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:26 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:26 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:26 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:26 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:26 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 10 20:02:27 rivoplus volumio[3292]: info: Preload queue cleared
Jul 10 20:02:27 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:27 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:27 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:29 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:29 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:29 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:30 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:30 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:30 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:31 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:31 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:31 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:32 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:32 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:32 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:33 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:33 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:33 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:34 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:34 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:34 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:36 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:36 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:36 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:36 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:36 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:36 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:38 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:38 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:38 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:38 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:38 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:38 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:39 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:39 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:39 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:41 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:41 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:41 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:42 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:42 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:42 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:43 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:43 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:43 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:44 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:44 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:44 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:45 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:45 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:45 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:46 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:46 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:46 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:46 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 10 20:02:46 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 10 20:02:46 rivoplus volumio[3292]: info: Discovery: Getting this device information
Jul 10 20:02:46 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:46 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:46 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 10 20:02:47 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:47 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:47 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:48 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:48 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:48 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:49 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:49 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:49 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:50 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:50 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:50 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:51 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:51 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:51 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:52 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:52 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:52 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:52 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:52 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:52 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:53 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:53 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:53 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:53 rivoplus volumio[3292]: error: error
Jul 10 20:02:54 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:54 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:54 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:55 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:55 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:55 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:56 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 10 20:02:56 rivoplus volumio[3292]: info: Preload queue cleared
Jul 10 20:02:56 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:56 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:56 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:57 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:57 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:57 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:58 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:58 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:58 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:02:58 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:02:58 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:02:58 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:00 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:00 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:00 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:01 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:01 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:01 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:02 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:02 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:02 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:03 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:03 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:03 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:04 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:04 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:04 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:05 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:05 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:05 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:06 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:06 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:06 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:07 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 10 20:03:07 rivoplus volumio[3292]: info: Preload queue cleared
Jul 10 20:03:07 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:07 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:07 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:08 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:08 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:08 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:09 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:09 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:09 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:10 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:10 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:10 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:11 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:11 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:11 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:11 rivoplus volumio[3292]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 10 20:03:12 rivoplus volumio[3292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Jul 10 20:03:12 rivoplus volumio[3292]: info: CoreCommandRouter::volumioGetState
Jul 10 20:03:12 rivoplus volumio[3292]: info: CorePlayQueue::getTrack 0
Jul 10 20:03:12 rivoplus volumio[3292]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 10 20:03:12 rivoplus volumio[3292]: TypeError: Cannot read property 'length' of undefined
Jul 10 20:03:12 rivoplus volumio[3292]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25
Jul 10 20:03:12 rivoplus volumio[3292]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13
Jul 10 20:03:12 rivoplus volumio[3292]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18)
Jul 10 20:03:12 rivoplus volumio[3292]: at Parser.emit (events.js:400:28)
Jul 10 20:03:12 rivoplus volumio[3292]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26)
Jul 10 20:03:12 rivoplus volumio[3292]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35)
Jul 10 20:03:12 rivoplus volumio[3292]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5)
Jul 10 20:03:12 rivoplus volumio[3292]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7)
Jul 10 20:03:12 rivoplus volumio[3292]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13)
Jul 10 20:03:12 rivoplus volumio[3292]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31)
Jul 10 20:03:12 rivoplus volumio[3292]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59)
Jul 10 20:03:12 rivoplus volumio[3292]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19)
Jul 10 20:03:12 rivoplus volumio[3292]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15)
Jul 10 20:03:12 rivoplus volumio[3292]: at IncomingMessage.emit (events.js:412:35)
Jul 10 20:03:12 rivoplus volumio[3292]: at endReadableNT (internal/streams/readable.js:1333:12)
Jul 10 20:03:12 rivoplus volumio[3292]: at processTicksAndRejections (internal/process/task_queues.js:82:21)
Jul 10 20:03:12 rivoplus volumio[3292]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 10 20:03:12 rivoplus sudo[5063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-10 20:02
Jul 10 20:03:12 rivoplus sudo[5063]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivoplus"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:55:44 PM CEST"
VOLUMIO_VERSION="3.819"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Rivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo"
VOLUMIO_HASH="66719bc94798fca30ca68a8e6d955a83"