-- Logs begin at Mon 2025-09-08 16:50:07 JST, end at Sun 2025-09-14 13:43:21 JST. --
Sep 14 13:42:00 rivo volumio[3505]: info:
Sep 14 13:42:00 rivo volumio[3505]: ---------------------------- MPD announces state update: player
Sep 14 13:42:00 rivo kernel: asoc-aml-card auge_sound: S/PDIF Playback disable
Sep 14 13:42:00 rivo kernel: spdif_a keep clk continuous
Sep 14 13:42:00 rivo kernel: aml_spdif_close
Sep 14 13:42:00 rivo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0
Sep 14 13:42:00 rivo volumio[3505]: info: ControllerMpd::getState
Sep 14 13:42:00 rivo volumio[3505]: verbose: ControllerMpd::sendMpdCommand status
Sep 14 13:42:00 rivo volumio[3505]: info:
Sep 14 13:42:00 rivo volumio[3505]: ---------------------------- MPD announces state update: player
Sep 14 13:42:00 rivo volumio[3505]: info: ControllerMpd::getState
Sep 14 13:42:00 rivo volumio[3505]: verbose: ControllerMpd::sendMpdCommand status
Sep 14 13:42:00 rivo volumio[3505]: info: sendMpdCommand status took 4 milliseconds
Sep 14 13:42:00 rivo volumio[3505]: info: sendMpdCommand status took 3 milliseconds
Sep 14 13:42:00 rivo volumio[3505]: verbose: ControllerMpd::parseState
Sep 14 13:42:00 rivo volumio[3505]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 14 13:42:00 rivo volumio[3505]: verbose: ControllerMpd::parseState
Sep 14 13:42:00 rivo volumio[3505]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 14 13:42:00 rivo volumio[3505]: info: sendMpdCommand playlistinfo took 3 milliseconds
Sep 14 13:42:00 rivo volumio[3505]: info: sendMpdCommand playlistinfo took 2 milliseconds
Sep 14 13:42:00 rivo volumio[3505]: verbose: ControllerMpd::parseTrackInfo
Sep 14 13:42:00 rivo volumio[3505]: verbose: ControllerMpd::parseTrackInfo
Sep 14 13:42:00 rivo volumio[3505]: info: ControllerMpd::pushState
Sep 14 13:42:00 rivo volumio[3505]: info: CoreCommandRouter::servicePushState
Sep 14 13:42:00 rivo volumio[3505]: verbose: In UPNP mode
Sep 14 13:42:00 rivo volumio[3505]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1480,"duration":290,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1389 Kbps","isStreaming":false,"title":"道化師のソネット","artist":"歌心りえ","album":"SONGS","uri":"http://192.168.0.7:17395/qobuz/325802217.flac","trackType":"qobuz"}
Sep 14 13:42:00 rivo volumio[3505]: verbose: CURRENT POSITION 0
Sep 14 13:42:00 rivo volumio[3505]: info: CoreStateMachine::syncState stateService pause
Sep 14 13:42:00 rivo volumio[3505]: info: CoreStateMachine::syncState currentStatus play
Sep 14 13:42:00 rivo volumio[3505]: info: CoreStateMachine::pushState
Sep 14 13:42:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 14 13:42:00 rivo volumio[3505]: info: CoreCommandRouter::volumioPushState
Sep 14 13:42:00 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:00 rivo volumio[3505]: info: CoreStateMachine::stPlaybackTimer
Sep 14 13:42:00 rivo volumio[3505]: info: ControllerMpd::pushState
Sep 14 13:42:00 rivo volumio[3505]: info: CoreCommandRouter::servicePushState
Sep 14 13:42:00 rivo volumio[3505]: verbose: In UPNP mode
Sep 14 13:42:00 rivo volumio[3505]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1480,"duration":290,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1389 Kbps","isStreaming":false,"title":"道化師のソネット","artist":"歌心りえ","album":"SONGS","uri":"http://192.168.0.7:17395/qobuz/325802217.flac","trackType":"qobuz"}
Sep 14 13:42:00 rivo volumio[3505]: verbose: CURRENT POSITION 0
Sep 14 13:42:00 rivo volumio[3505]: info: CoreStateMachine::syncState stateService pause
Sep 14 13:42:00 rivo volumio[3505]: info: CoreStateMachine::syncState currentStatus play
Sep 14 13:42:00 rivo volumio[3505]: info: CoreStateMachine::pushState
Sep 14 13:42:00 rivo volumio[3505]: info: CoreCommandRouter::volumioPushState
Sep 14 13:42:00 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:00 rivo volumio[3505]: info: CoreStateMachine::stPlaybackTimer
Sep 14 13:42:00 rivo volumio[3505]: info: ------------------------------ 68ms
Sep 14 13:42:00 rivo volumio[3505]: info: ------------------------------ 66ms
Sep 14 13:42:00 rivo volumio[3505]: info: CoreCommandRouter::volumioGetQueue
Sep 14 13:42:00 rivo volumio[3505]: info: CoreStateMachine::getQueue
Sep 14 13:42:00 rivo volumio[3505]: info: CorePlayQueue::getQueue
Sep 14 13:42:00 rivo volumio[3505]: info: CoreCommandRouter::volumioGetQueue
Sep 14 13:42:00 rivo volumio[3505]: info: CoreStateMachine::getQueue
Sep 14 13:42:00 rivo volumio[3505]: info: CorePlayQueue::getQueue
Sep 14 13:42:00 rivo volumio[3505]: info: MCU Signalled Playback Inactive
Sep 14 13:42:07 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 13:42:07 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 13:42:07 rivo volumio[3505]: info: Discovery: Getting this device information
Sep 14 13:42:07 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:07 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 13:42:37 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 13:42:37 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 13:42:37 rivo volumio[3505]: info: Discovery: Getting this device information
Sep 14 13:42:37 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:37 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 13:42:43 rivo mpd_monitor.sh[2836]: MPD Monitor Service: MPD Appears to be inactive, restarting
Sep 14 13:42:43 rivo systemd[1]: Stopping Music Player Daemon...
Sep 14 13:42:44 rivo volumio[3505]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Sep 14 13:42:44 rivo volumio[3505]: info: Preparing to save Alsa Options, stopping services first
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::volumioPause
Sep 14 13:42:44 rivo volumio[3505]: info: CoreStateMachine::pause
Sep 14 13:42:44 rivo volumio[3505]: info: CoreStateMachine::stPlaybackTimer
Sep 14 13:42:44 rivo volumio[3505]: info: CoreStateMachine::servicePause
Sep 14 13:42:44 rivo volumio[3505]: info: CorePlayQueue::getTrack 0
Sep 14 13:42:44 rivo volumio[3505]: info: Error: no service or no trackblock to pause
Sep 14 13:42:44 rivo volumio[3505]: info: Saving Audio Output to: {"output_device":{"value":"0,2","label":"S/PDIF + AES/EBU"}}
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 14 13:42:44 rivo volumio[3505]: info: Found match in Cards Database for ignoring default Mixer
Sep 14 13:42:44 rivo volumio[3505]: info: Setting mixer Audio hdmi-out mute for card S/PDIF + AES/EBU
Sep 14 13:42:44 rivo volumio[3505]: info: QobuzConnect: setDeactiveState invoked
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:44 rivo volumio[3505]: info: Ignoring Mixers Options
Sep 14 13:42:44 rivo volumio[3505]: info: Device 0 does not have any Mixer Control Available
Sep 14 13:42:44 rivo volumio[3505]: info: QobuzConnect: setDeactiveState invoked
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Sep 14 13:42:44 rivo volumio[3505]: info: Updating Volume Controller Parameters: Device: 0,2 Name: S/PDIF + AES/EBU Mixer: Audio hdmi-out mute Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Sep 14 13:42:44 rivo volumio[3505]: info: Disabling external Volume Control
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 14 13:42:44 rivo volumio[3505]: info: CoreStateMachine::pushState
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::volumioPushState
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:44 rivo volumio[3505]: info: Preparing to generate the ALSA configuration file
Sep 14 13:42:44 rivo sudo[5651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Sep 14 13:42:44 rivo sudo[5651]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::volumioGetQueue
Sep 14 13:42:44 rivo volumio[3505]: info: CoreStateMachine::getQueue
Sep 14 13:42:44 rivo volumio[3505]: info: CorePlayQueue::getQueue
Sep 14 13:42:44 rivo sudo[5651]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:44 rivo sudo[5658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Sep 14 13:42:44 rivo sudo[5658]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:44 rivo sudo[5659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Sep 14 13:42:44 rivo sudo[5659]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:44 rivo sudo[5658]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:44 rivo systemd[1]: Stopping Volumio Qobuz Connect Service...
Sep 14 13:42:44 rivo qobuz-connect[5226]: 20250914 13:42:44.910 [5226.5226] INFO SampleApp: Stopping Local configuration server
Sep 14 13:42:44 rivo sudo[5663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Sep 14 13:42:44 rivo sudo[5663]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:44 rivo qobuz-connect[5226]: 20250914 13:42:44.920 [5226.5226] INFO SampleApp: shat down connection on UNIX socket
Sep 14 13:42:44 rivo systemd[1]: qobuz-connect.service: Succeeded.
Sep 14 13:42:44 rivo systemd[1]: Stopped Volumio Qobuz Connect Service.
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 14 13:42:44 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 14 13:42:44 rivo systemd[1]: Started Volumio Qobuz Connect Service.
Sep 14 13:42:44 rivo sudo[5659]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:44 rivo systemd[1]: Stopping Volumio Qobuz Connect Service...
Sep 14 13:42:44 rivo systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT
Sep 14 13:42:44 rivo systemd[1]: qobuz-connect.service: Succeeded.
Sep 14 13:42:44 rivo systemd[1]: Stopped Volumio Qobuz Connect Service.
Sep 14 13:42:45 rivo systemd[1]: Started Volumio Qobuz Connect Service.
Sep 14 13:42:45 rivo sudo[5663]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Sep 14 13:42:45 rivo volumio[3505]: info: Asound.conf file unchanged, so no further update is needed
Sep 14 13:42:45 rivo volumio[3505]: info: Output device has changed, restarting MPD
Sep 14 13:42:45 rivo volumio[3505]: info: QobuzConnect: setDeactiveState invoked
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 14 13:42:45 rivo sudo[5681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 14 13:42:45 rivo sudo[5681]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:45 rivo sudo[5681]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:45 rivo sudo[5684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 14 13:42:45 rivo sudo[5684]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:45 rivo sudo[5691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Sep 14 13:42:45 rivo sudo[5691]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:45 rivo volumio[3505]: info: MPD Permissions set
Sep 14 13:42:45 rivo volumio[3505]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Sep 14 13:42:45 rivo volumio[3505]: info: QobuzConnect: setDeactiveState invoked
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:45 rivo volumio[3505]: info: CoreStateMachine::pushState
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::volumioPushState
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:45 rivo sudo[5691]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::volumioGetQueue
Sep 14 13:42:45 rivo volumio[3505]: info: CoreStateMachine::getQueue
Sep 14 13:42:45 rivo volumio[3505]: info: CorePlayQueue::getQueue
Sep 14 13:42:45 rivo sudo[5693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Sep 14 13:42:45 rivo sudo[5693]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:45 rivo volumio[3505]: info: Executing endpoint qc_getconfig
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Sep 14 13:42:45 rivo qobuz-connect[5678]: 20250914 13:42:45.235 [5678.5678] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 14 13:42:45 rivo qobuz-connect[5678]: 20250914 13:42:45.242 [5678.5678] INFO VolumeManager: [0xabdad240]: Setting new playback volume: 75
Sep 14 13:42:45 rivo qobuz-connect[5678]: 20250914 13:42:45.243 [5678.5678] INFO VolumeManager: [0xabdad240]: Setting new mute state: 0
Sep 14 13:42:45 rivo qobuz-connect[5678]: 20250914 13:42:45.243 [5678.5678] INFO QobuzConnect: [0xabdadc10]: Client initialized!
Sep 14 13:42:45 rivo qobuz-connect[5678]: 20250914 13:42:45.243 [5678.5678] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp
Sep 14 13:42:45 rivo qobuz-connect[5678]: 20250914 13:42:45.261 [5678.5678] INFO LocalConfigManager: [0xabdacb20]: Starting Local Configuration server
Sep 14 13:42:45 rivo qobuz-connect[5678]: 20250914 13:42:45.261 [5678.5678] INFO SampleApp: Starting Local configuration server
Sep 14 13:42:45 rivo qobuz-connect[5678]: 20250914 13:42:45.262 [5678.5678] INFO SampleApp: Connected to UNIX socket client 0xabda2ed8
Sep 14 13:42:45 rivo systemd[1]: Stopping Volumio Qobuz Connect Service...
Sep 14 13:42:45 rivo qobuz-connect[5678]: 20250914 13:42:45.266 [5678.5678] INFO SampleApp: Stopping Local configuration server
Sep 14 13:42:45 rivo qobuz-connect[5678]: 20250914 13:42:45.277 [5678.5678] INFO SampleApp: shat down connection on UNIX socket
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Sep 14 13:42:45 rivo systemd[1]: qobuz-connect.service: Succeeded.
Sep 14 13:42:45 rivo systemd[1]: Stopped Volumio Qobuz Connect Service.
Sep 14 13:42:45 rivo systemd[1]: Started Volumio Qobuz Connect Service.
Sep 14 13:42:45 rivo sudo[5693]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 14 13:42:45 rivo volumio[3505]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Sep 14 13:42:45 rivo volumio[3505]: info: QobuzConnect: QOBUZ Connect daemon connected
Sep 14 13:42:45 rivo volumio[3505]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Sep 14 13:42:45 rivo volumio[3505]: info: QobuzConnect: setDeactiveState invoked
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:45 rivo volumio[3505]: info: Executing endpoint qc_getconfig
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Sep 14 13:42:45 rivo qobuz-connect[5701]: 20250914 13:42:45.379 [5701.5701] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Sep 14 13:42:45 rivo volumio[3505]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Sep 14 13:42:45 rivo volumio[3505]: info: QobuzConnect: QOBUZ Connect daemon connected
Sep 14 13:42:45 rivo qobuz-connect[5701]: 20250914 13:42:45.386 [5701.5701] INFO VolumeManager: [0xace9e240]: Setting new playback volume: 75
Sep 14 13:42:45 rivo qobuz-connect[5701]: 20250914 13:42:45.386 [5701.5701] INFO VolumeManager: [0xace9e240]: Setting new mute state: 0
Sep 14 13:42:45 rivo qobuz-connect[5701]: 20250914 13:42:45.386 [5701.5701] INFO QobuzConnect: [0xace9ec10]: Client initialized!
Sep 14 13:42:45 rivo qobuz-connect[5701]: 20250914 13:42:45.386 [5701.5701] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp
Sep 14 13:42:45 rivo qobuz-connect[5701]: 20250914 13:42:45.401 [5701.5701] INFO LocalConfigManager: [0xace9db20]: Starting Local Configuration server
Sep 14 13:42:45 rivo qobuz-connect[5701]: 20250914 13:42:45.401 [5701.5701] INFO SampleApp: Starting Local configuration server
Sep 14 13:42:45 rivo qobuz-connect[5701]: 20250914 13:42:45.401 [5701.5701] INFO SampleApp: Connected to UNIX socket client 0xace93ed8
Sep 14 13:42:45 rivo qobuz-connect[5701]: 20250914 13:42:45.529 [5701.5701] INFO SampleApp: Playback volume changed: 75
Sep 14 13:42:45 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:47 rivo volumio[3505]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Sep 14 13:42:47 rivo volumio[3505]: info: Preparing to save Alsa Options, stopping services first
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioPause
Sep 14 13:42:47 rivo volumio[3505]: info: CoreStateMachine::pause
Sep 14 13:42:47 rivo volumio[3505]: info: Saving Audio Output to: {"output_device":{"value":"0,2","label":"S/PDIF + AES/EBU"}}
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 14 13:42:47 rivo volumio[3505]: info: Found match in Cards Database for ignoring default Mixer
Sep 14 13:42:47 rivo volumio[3505]: info: Setting mixer Audio hdmi-out mute for card S/PDIF + AES/EBU
Sep 14 13:42:47 rivo volumio[3505]: info: QobuzConnect: setDeactiveState invoked
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:47 rivo volumio[3505]: info: Ignoring Mixers Options
Sep 14 13:42:47 rivo volumio[3505]: info: Device 0 does not have any Mixer Control Available
Sep 14 13:42:47 rivo volumio[3505]: info: QobuzConnect: setDeactiveState invoked
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Sep 14 13:42:47 rivo volumio[3505]: info: Updating Volume Controller Parameters: Device: 0,2 Name: S/PDIF + AES/EBU Mixer: Audio hdmi-out mute Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Sep 14 13:42:47 rivo volumio[3505]: info: Disabling external Volume Control
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 14 13:42:47 rivo volumio[3505]: info: CoreStateMachine::pushState
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioPushState
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:47 rivo volumio[3505]: info: Preparing to generate the ALSA configuration file
Sep 14 13:42:47 rivo sudo[5719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Sep 14 13:42:47 rivo sudo[5719]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:47 rivo sudo[5719]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioGetQueue
Sep 14 13:42:47 rivo volumio[3505]: info: CoreStateMachine::getQueue
Sep 14 13:42:47 rivo volumio[3505]: info: CorePlayQueue::getQueue
Sep 14 13:42:47 rivo sudo[5725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Sep 14 13:42:47 rivo sudo[5725]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:47 rivo sudo[5726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Sep 14 13:42:47 rivo sudo[5726]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:47 rivo sudo[5726]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:47 rivo systemd[1]: Stopping Volumio Qobuz Connect Service...
Sep 14 13:42:47 rivo qobuz-connect[5701]: 20250914 13:42:47.575 [5701.5701] INFO SampleApp: Stopping Local configuration server
Sep 14 13:42:47 rivo qobuz-connect[5701]: 20250914 13:42:47.585 [5701.5701] INFO SampleApp: shat down connection on UNIX socket
Sep 14 13:42:47 rivo systemd[1]: qobuz-connect.service: Succeeded.
Sep 14 13:42:47 rivo systemd[1]: Stopped Volumio Qobuz Connect Service.
Sep 14 13:42:47 rivo sudo[5730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Sep 14 13:42:47 rivo sudo[5730]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:47 rivo systemd[1]: Started Volumio Qobuz Connect Service.
Sep 14 13:42:47 rivo sudo[5725]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 14 13:42:47 rivo systemd[1]: Stopping Volumio Qobuz Connect Service...
Sep 14 13:42:47 rivo systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT
Sep 14 13:42:47 rivo systemd[1]: qobuz-connect.service: Succeeded.
Sep 14 13:42:47 rivo systemd[1]: Stopped Volumio Qobuz Connect Service.
Sep 14 13:42:47 rivo systemd[1]: Started Volumio Qobuz Connect Service.
Sep 14 13:42:47 rivo sudo[5730]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Sep 14 13:42:47 rivo volumio[3505]: info: Asound.conf file unchanged, so no further update is needed
Sep 14 13:42:47 rivo volumio[3505]: info: Output device has changed, restarting MPD
Sep 14 13:42:47 rivo volumio[3505]: info: QobuzConnect: setDeactiveState invoked
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 14 13:42:47 rivo sudo[5739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 14 13:42:47 rivo sudo[5739]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:47 rivo sudo[5739]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:47 rivo sudo[5741]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 14 13:42:47 rivo sudo[5741]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:47 rivo sudo[5748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Sep 14 13:42:47 rivo sudo[5748]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:47 rivo volumio[3505]: info: MPD Permissions set
Sep 14 13:42:47 rivo volumio[3505]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Sep 14 13:42:47 rivo volumio[3505]: info: QobuzConnect: setDeactiveState invoked
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:47 rivo volumio[3505]: info: CoreStateMachine::pushState
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioPushState
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:47 rivo sudo[5748]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioGetQueue
Sep 14 13:42:47 rivo volumio[3505]: info: CoreStateMachine::getQueue
Sep 14 13:42:47 rivo volumio[3505]: info: CorePlayQueue::getQueue
Sep 14 13:42:47 rivo sudo[5750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Sep 14 13:42:47 rivo sudo[5750]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:42:47 rivo volumio[3505]: info: Executing endpoint qc_getconfig
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Sep 14 13:42:47 rivo qobuz-connect[5735]: 20250914 13:42:47.893 [5735.5735] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 14 13:42:47 rivo qobuz-connect[5735]: 20250914 13:42:47.899 [5735.5735] INFO VolumeManager: [0xab450240]: Setting new playback volume: 75
Sep 14 13:42:47 rivo qobuz-connect[5735]: 20250914 13:42:47.900 [5735.5735] INFO VolumeManager: [0xab450240]: Setting new mute state: 0
Sep 14 13:42:47 rivo qobuz-connect[5735]: 20250914 13:42:47.900 [5735.5735] INFO QobuzConnect: [0xab450c10]: Client initialized!
Sep 14 13:42:47 rivo qobuz-connect[5735]: 20250914 13:42:47.900 [5735.5735] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp
Sep 14 13:42:47 rivo qobuz-connect[5735]: 20250914 13:42:47.915 [5735.5735] INFO LocalConfigManager: [0xab44fb20]: Starting Local Configuration server
Sep 14 13:42:47 rivo qobuz-connect[5735]: 20250914 13:42:47.915 [5735.5735] INFO SampleApp: Starting Local configuration server
Sep 14 13:42:47 rivo qobuz-connect[5735]: 20250914 13:42:47.916 [5735.5735] INFO SampleApp: Connected to UNIX socket client 0xab445ed8
Sep 14 13:42:47 rivo systemd[1]: Stopping Volumio Qobuz Connect Service...
Sep 14 13:42:47 rivo qobuz-connect[5735]: 20250914 13:42:47.928 [5735.5735] INFO SampleApp: Stopping Local configuration server
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 14 13:42:47 rivo qobuz-connect[5735]: 20250914 13:42:47.938 [5735.5735] INFO SampleApp: shat down connection on UNIX socket
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Sep 14 13:42:47 rivo systemd[1]: qobuz-connect.service: Succeeded.
Sep 14 13:42:47 rivo systemd[1]: Stopped Volumio Qobuz Connect Service.
Sep 14 13:42:47 rivo systemd[1]: Started Volumio Qobuz Connect Service.
Sep 14 13:42:47 rivo sudo[5750]: pam_unix(sudo:session): session closed for user root
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 14 13:42:47 rivo volumio[3505]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Sep 14 13:42:47 rivo volumio[3505]: info: QobuzConnect: QOBUZ Connect daemon connected
Sep 14 13:42:47 rivo volumio[3505]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Sep 14 13:42:47 rivo volumio[3505]: info: QobuzConnect: setDeactiveState invoked
Sep 14 13:42:47 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:48 rivo volumio[3505]: info: Executing endpoint qc_getconfig
Sep 14 13:42:48 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Sep 14 13:42:48 rivo qobuz-connect[5758]: 20250914 13:42:48.043 [5758.5758] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Sep 14 13:42:48 rivo volumio[3505]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Sep 14 13:42:48 rivo volumio[3505]: info: QobuzConnect: QOBUZ Connect daemon connected
Sep 14 13:42:48 rivo qobuz-connect[5758]: 20250914 13:42:48.050 [5758.5758] INFO VolumeManager: [0xacbbf240]: Setting new playback volume: 75
Sep 14 13:42:48 rivo qobuz-connect[5758]: 20250914 13:42:48.050 [5758.5758] INFO VolumeManager: [0xacbbf240]: Setting new mute state: 0
Sep 14 13:42:48 rivo qobuz-connect[5758]: 20250914 13:42:48.050 [5758.5758] INFO QobuzConnect: [0xacbbfc10]: Client initialized!
Sep 14 13:42:48 rivo qobuz-connect[5758]: 20250914 13:42:48.050 [5758.5758] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp
Sep 14 13:42:48 rivo qobuz-connect[5758]: 20250914 13:42:48.061 [5758.5758] INFO LocalConfigManager: [0xacbbeb20]: Starting Local Configuration server
Sep 14 13:42:48 rivo qobuz-connect[5758]: 20250914 13:42:48.061 [5758.5758] INFO SampleApp: Starting Local configuration server
Sep 14 13:42:48 rivo qobuz-connect[5758]: 20250914 13:42:48.062 [5758.5758] INFO SampleApp: Connected to UNIX socket client 0xacbb4ed8
Sep 14 13:42:48 rivo qobuz-connect[5758]: 20250914 13:42:48.194 [5758.5758] INFO SampleApp: Playback volume changed: 75
Sep 14 13:42:48 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:48 rivo volumio[3505]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Sep 14 13:42:48 rivo volumio[3505]: info: CoreStateMachine::getcurrentVolume
Sep 14 13:42:48 rivo volumio[3505]: info: CoreCommandRouter::volumioRetrievevolume
Sep 14 13:42:48 rivo volumio[3505]: info: CoreStateMachine::pushState
Sep 14 13:42:48 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 14 13:42:48 rivo volumio[3505]: info: CoreCommandRouter::volumioPushState
Sep 14 13:42:48 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:48 rivo volumio[3505]: info: CoreCommandRouter::volumioGetQueue
Sep 14 13:42:48 rivo volumio[3505]: info: CoreStateMachine::getQueue
Sep 14 13:42:48 rivo volumio[3505]: info: CorePlayQueue::getQueue
Sep 14 13:42:51 rivo volumio[3505]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Sep 14 13:42:51 rivo volumio[3505]: info: CoreStateMachine::getcurrentVolume
Sep 14 13:42:51 rivo volumio[3505]: info: CoreCommandRouter::volumioRetrievevolume
Sep 14 13:42:51 rivo volumio[3505]: info: CoreStateMachine::pushState
Sep 14 13:42:51 rivo volumio[3505]: info: CoreCommandRouter::volumioPushState
Sep 14 13:42:51 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:42:51 rivo volumio[3505]: info: CoreCommandRouter::volumioGetQueue
Sep 14 13:42:51 rivo volumio[3505]: info: CoreStateMachine::getQueue
Sep 14 13:42:51 rivo volumio[3505]: info: CorePlayQueue::getQueue
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Sep 14 13:43:00 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Sep 14 13:43:07 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 14 13:43:07 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 14 13:43:07 rivo volumio[3505]: info: Discovery: Getting this device information
Sep 14 13:43:07 rivo volumio[3505]: info: CoreCommandRouter::volumioGetState
Sep 14 13:43:07 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 14 13:43:10 rivo volumio[3505]: info: Retrieving Cloud Streaming UI
Sep 14 13:43:10 rivo volumio[3505]: info: Getting Tidal Cloud Configuration
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 14 13:43:10 rivo volumio[3505]: info: Getting Qobuz Cloud Configuration
Sep 14 13:43:10 rivo volumio[3505]: info: Asking plugin for UI Config
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 14 13:43:10 rivo volumio[3505]: info: Getting Spotify Cloud Configuration
Sep 14 13:43:10 rivo volumio[3505]: info: Asking plugin for UI Config
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 14 13:43:10 rivo volumio[3505]: info: Saving Spotify Acccount
Sep 14 13:43:10 rivo volumio[3505]: info: Got it
Sep 14 13:43:10 rivo volumio[3505]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Sep 14 13:43:10 rivo volumio[3505]: info: Got Tidal Cloud Configuration
Sep 14 13:43:10 rivo volumio[3505]: info: Got it
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 14 13:43:10 rivo volumio[3505]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 14 13:43:11 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 14 13:43:12 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 14 13:43:15 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 14 13:43:17 rivo volumio[3505]: info: Disabling MyMusic plugin upnp
Sep 14 13:43:17 rivo sudo[5826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Sep 14 13:43:17 rivo sudo[5826]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 14 13:43:17 rivo volumio[3505]: error: Upnp client error: Error: This socket has been ended by the other party
Sep 14 13:43:17 rivo systemd[1]: Stopping UPnP Renderer front-end to MPD...
Sep 14 13:43:19 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 14 13:43:20 rivo volumio[3505]: info: Enabling MyMusic plugin upnp
Sep 14 13:43:20 rivo volumio[3505]: info: Enabling plugin upnp
Sep 14 13:43:20 rivo volumio[3505]: info: Loading plugin "upnp"...
Sep 14 13:43:20 rivo volumio[3505]: info: [1757825000463] Starting Upmpd Daemon
Sep 14 13:43:20 rivo volumio[3505]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 14 13:43:20 rivo volumio[3505]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 14 13:43:20 rivo volumio[3505]: Error: listen EADDRINUSE: address already in use :::6599
Sep 14 13:43:20 rivo volumio[3505]: at Server.setupListenHandle [as _listen2] (net.js:1331:16)
Sep 14 13:43:20 rivo volumio[3505]: at listenInCluster (net.js:1379:12)
Sep 14 13:43:20 rivo volumio[3505]: at Server.listen (net.js:1465:7)
Sep 14 13:43:20 rivo volumio[3505]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
Sep 14 13:43:20 rivo volumio[3505]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
Sep 14 13:43:20 rivo volumio[3505]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Sep 14 13:43:20 rivo volumio[3505]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Sep 14 13:43:20 rivo volumio[3505]: at processTicksAndRejections (internal/process/task_queues.js:77:11) {
Sep 14 13:43:20 rivo volumio[3505]: code: 'EADDRINUSE',
Sep 14 13:43:20 rivo volumio[3505]: errno: -98,
Sep 14 13:43:20 rivo volumio[3505]: syscall: 'listen',
Sep 14 13:43:20 rivo volumio[3505]: address: '::',
Sep 14 13:43:20 rivo volumio[3505]: port: 6599
Sep 14 13:43:20 rivo volumio[3505]: }
Sep 14 13:43:20 rivo volumio[3505]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 14 13:43:21 rivo sudo[5837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-14 13:42
Sep 14 13:43:21 rivo sudo[5837]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivo"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:43:09 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Rivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo"
VOLUMIO_HASH="fc7d09bc07ffd188bff4808d8f79c746"