-- Logs begin at Mon 2025-05-26 08:40:03 CEST, end at Wed 2025-05-28 08:46:23 CEST. --
May 28 08:45:13 rivo volumio[3120]: verbose: New Socket.io Connection to 192.168.1.124 from 192.168.1.26 UA: Mozilla/5.0 (Linux; Android 13; SM-G985F Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
May 28 08:45:14 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 28 08:45:14 rivo volumio[3120]: info: CoreCommandRouter::volumioGetVisibleSources
May 28 08:45:14 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 28 08:45:14 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:14 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:14 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 28 08:45:14 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 28 08:45:14 rivo volumio[3120]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
May 28 08:45:14 rivo volumio[3120]: info: Received Get System Info
May 28 08:45:14 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 28 08:45:14 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 28 08:45:14 rivo volumio[3120]: info: Discovery: Getting this device information
May 28 08:45:14 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:14 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:14 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 28 08:45:14 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:14 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:14 rivo volumio[3120]: info: Listing playlists
May 28 08:45:14 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 28 08:45:16 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:16 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:17 rivo sudo[2562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 28 08:45:17 rivo sudo[2562]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:17 rivo sudo[2562]: pam_unix(sudo:session): session closed for user root
May 28 08:45:17 rivo sudo[2566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 28 08:45:17 rivo sudo[2566]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:17 rivo sudo[2566]: pam_unix(sudo:session): session closed for user root
May 28 08:45:17 rivo volumio[3120]: verbose: New Socket.io Connection to 192.168.1.124 from 192.168.1.26 UA: Mozilla/5.0 (Linux; Android 13; SM-G985F Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
May 28 08:45:17 rivo sudo[2572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 28 08:45:17 rivo sudo[2572]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:17 rivo sudo[2572]: pam_unix(sudo:session): session closed for user root
May 28 08:45:17 rivo sudo[2576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 28 08:45:17 rivo sudo[2576]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:17 rivo sudo[2576]: pam_unix(sudo:session): session closed for user root
May 28 08:45:17 rivo volumio[3120]: verbose: New Socket.io Connection to 192.168.1.124 from 192.168.1.26 UA: Mozilla/5.0 (Linux; Android 13; SM-G985F Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.61 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12
May 28 08:45:17 rivo go-librespot[32138]: time="2025-05-28T08:45:17+02:00" level=trace msg="sent dealer ping"
May 28 08:45:17 rivo go-librespot[32138]: time="2025-05-28T08:45:17+02:00" level=trace msg="received dealer pong"
May 28 08:45:17 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::volumioGetVisibleSources
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:18 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 28 08:45:18 rivo volumio[3120]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
May 28 08:45:18 rivo volumio[3120]: info: Received Get System Info
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 28 08:45:18 rivo volumio[3120]: info: Discovery: Getting this device information
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:18 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:18 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:18 rivo volumio[3120]: info: Listing playlists
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 28 08:45:18 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 28 08:45:19 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 28 08:45:19 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 28 08:45:19 rivo volumio[3120]: info: Received Get System Info
May 28 08:45:19 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 28 08:45:19 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 28 08:45:19 rivo volumio[3120]: info: Discovery: Getting this device information
May 28 08:45:19 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:19 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:19 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 28 08:45:20 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 28 08:45:20 rivo volumio[3120]: info: Received Get System Info
May 28 08:45:20 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 28 08:45:20 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 28 08:45:20 rivo volumio[3120]: info: Discovery: Getting this device information
May 28 08:45:20 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:20 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:20 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 28 08:45:26 rivo volumio[3120]: info: MCU Signalled Sleep Mode Active
May 28 08:45:26 rivo sudo[2649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force off
May 28 08:45:26 rivo sudo[2649]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:26 rivo kernel: fb: osd[0] enable: 1 (Xorg)
May 28 08:45:26 rivo kernel: fb: osd[0] enable: 0 (Xorg)
May 28 08:45:26 rivo kernel: fb: osd[0] enable: 0 (Xorg)
May 28 08:45:26 rivo sudo[2649]: pam_unix(sudo:session): session closed for user root
May 28 08:45:26 rivo volumio[3120]: info: Enabling Screen Saver via dpms
May 28 08:45:27 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 28 08:45:27 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 28 08:45:27 rivo volumio[3120]: info: Discovery: Getting this device information
May 28 08:45:27 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:27 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:27 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 28 08:45:27 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 08:45:28 rivo volumio[3120]: info: Retrieving Cloud Streaming UI
May 28 08:45:28 rivo volumio[3120]: info: Getting Tidal Cloud Configuration
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 08:45:28 rivo volumio[3120]: info: Getting Qobuz Cloud Configuration
May 28 08:45:28 rivo volumio[3120]: info: Asking plugin for UI Config
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 08:45:28 rivo volumio[3120]: info: Getting Spotify Cloud Configuration
May 28 08:45:28 rivo volumio[3120]: info: Asking plugin for UI Config
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 08:45:28 rivo volumio[3120]: info: Saving Spotify Acccount
May 28 08:45:28 rivo volumio[3120]: info: Got it
May 28 08:45:28 rivo volumio[3120]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 28 08:45:28 rivo volumio[3120]: info: Got Tidal Cloud Configuration
May 28 08:45:28 rivo volumio[3120]: info: Got it
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::volumioGetBrowseSources
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::volumioGetBrowseSources
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::volumioGetBrowseSources
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:45:28 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 28 08:45:32 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:45:33 rivo volumio[3120]: info: Disabling MyMusic plugin bluetooth
May 28 08:45:33 rivo sudo[2652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service
May 28 08:45:33 rivo sudo[2652]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:33 rivo systemd[1]: Stopping Volumio Bluetooth Module...
May 28 08:45:33 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:33 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:33 rivo volumiobt[2654]: Killing pulse
May 28 08:45:33 rivo bluetoothd[3305]: Endpoint unregistered: sender=:1.78 path=/MediaEndpoint/A2DPSource
May 28 08:45:33 rivo bluetoothd[3305]: Endpoint unregistered: sender=:1.78 path=/MediaEndpoint/A2DPSink
May 28 08:45:33 rivo volumiobt[2654]: Killing BT Pair agent
May 28 08:45:33 rivo volumiobt[857]: Terminated
May 28 08:45:33 rivo systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM
May 28 08:45:33 rivo sudo[2658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
May 28 08:45:33 rivo sudo[2658]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:33 rivo sudo[2658]: pam_unix(sudo:session): session closed for user root
May 28 08:45:33 rivo systemd[1]: volumiobt.service: Succeeded.
May 28 08:45:33 rivo systemd[1]: Stopped Volumio Bluetooth Module.
May 28 08:45:33 rivo sudo[2652]: pam_unix(sudo:session): session closed for user root
May 28 08:45:33 rivo volumio[3120]: info: Touch event received, exiting sleep mode
May 28 08:45:33 rivo volumio[3120]: info: Volumio BT Module successfully stopped
May 28 08:45:33 rivo volumio[3120]: info: Disabling plugin bluetooth
May 28 08:45:33 rivo volumio[3120]: info: Done.
May 28 08:45:33 rivo volumio[3120]: info: MCU Signalled Sleep Mode Disabled
May 28 08:45:33 rivo sudo[2661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on
May 28 08:45:33 rivo sudo[2661]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:33 rivo kernel: fb: osd[0] enable: 1 (Xorg)
May 28 08:45:33 rivo kernel: fb: osd[0] enable: 1 (Xorg)
May 28 08:45:33 rivo sudo[2661]: pam_unix(sudo:session): session closed for user root
May 28 08:45:33 rivo sudo[2664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0
May 28 08:45:33 rivo sudo[2664]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:33 rivo sudo[2664]: pam_unix(sudo:session): session closed for user root
May 28 08:45:36 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 28 08:45:36 rivo volumio[3120]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
May 28 08:45:36 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
May 28 08:45:36 rivo volumio[3120]: info: Received Get System Version
May 28 08:45:36 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 28 08:45:36 rivo volumio[3120]: info: Received Get System Info
May 28 08:45:36 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 28 08:45:36 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 28 08:45:36 rivo volumio[3120]: info: Discovery: Getting this device information
May 28 08:45:36 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:36 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:36 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 28 08:45:36 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:45:36 rivo volumio[3120]: info: Disabling MyMusic plugin multiroom
May 28 08:45:36 rivo volumio[3120]: info: Disabling plugin multiroom
May 28 08:45:36 rivo volumio[3120]: info: Preparing to generate the ALSA configuration file
May 28 08:45:36 rivo volumio[3120]: info: Asound.conf file written
May 28 08:45:36 rivo sudo[2690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
May 28 08:45:36 rivo sudo[2690]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:36 rivo sudo[2690]: pam_unix(sudo:session): session closed for user root
May 28 08:45:37 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994
May 28 08:45:37 rivo kernel: Err: can not set rate to 4290967296!
May 28 08:45:37 rivo kernel: Range[3920000 - 500000000]
May 28 08:45:37 rivo kernel: out of value, fixed it
May 28 08:45:37 rivo kernel: id=0 set inskew=0
May 28 08:45:37 rivo volumio[3120]: No protocol specified
May 28 08:45:37 rivo volumio[3120]: xcb_connection_has_error() returned true
May 28 08:45:37 rivo volumio[3120]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted
May 28 08:45:37 rivo volumio[3120]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted
May 28 08:45:37 rivo volumio[3120]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted
May 28 08:45:37 rivo volumio[3120]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted
May 28 08:45:37 rivo volumio[3120]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Clock Source 41 Validity:0' : Operation not permitted
May 28 08:45:37 rivo volumio[3120]: info: Output device has changed, restarting MPD
May 28 08:45:37 rivo sudo[2695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 28 08:45:37 rivo sudo[2695]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:37 rivo sudo[2695]: pam_unix(sudo:session): session closed for user root
May 28 08:45:37 rivo volumio[3120]: info: Output device has changed, restarting Shairport Sync
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 28 08:45:37 rivo sudo[2698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 28 08:45:37 rivo sudo[2698]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:37 rivo systemd[1]: Stopping Music Player Daemon...
May 28 08:45:37 rivo volumio[3120]: No protocol specified
May 28 08:45:37 rivo volumio[3120]: xcb_connection_has_error() returned true
May 28 08:45:37 rivo volumio[3120]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 28 08:45:37 rivo volumio[3120]: No protocol specified
May 28 08:45:37 rivo volumio[3120]: xcb_connection_has_error() returned true
May 28 08:45:37 rivo volumio[3120]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: QobuzConnect: setDeactiveState invoked
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:37 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:37 rivo volumio[3120]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo vtcs[28016]: [2025-05-28 08:45:37.195] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE
May 28 08:45:37 rivo vtcs[28016]: [2025-05-28 08:45:37.196] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=8 errorno=104 error=Connection reset by peer
May 28 08:45:37 rivo vtcs[28016]: [2025-05-28 08:45:37.196] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected
May 28 08:45:37 rivo systemd[1]: mpd.service: Succeeded.
May 28 08:45:37 rivo systemd[1]: Stopped Music Player Daemon.
May 28 08:45:37 rivo systemd[1]: Starting Music Player Daemon...
May 28 08:45:37 rivo volumio[3120]: info: Done.
May 28 08:45:37 rivo sudo[2713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
May 28 08:45:37 rivo sudo[2713]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:37 rivo systemd[1]: Stopping Volumio Tidal Connect Service...
May 28 08:45:37 rivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
May 28 08:45:37 rivo sudo[2718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
May 28 08:45:37 rivo sudo[2718]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:37 rivo systemd[1]: vtcs.service: Succeeded.
May 28 08:45:37 rivo systemd[1]: Stopped Volumio Tidal Connect Service.
May 28 08:45:37 rivo sudo[2707]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 28 08:45:37 rivo sudo[2713]: pam_unix(sudo:session): session closed for user root
May 28 08:45:37 rivo sudo[2707]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:37 rivo sudo[2707]: pam_unix(sudo:session): session closed for user root
May 28 08:45:37 rivo sudo[2718]: pam_unix(sudo:session): session closed for user root
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:37 rivo sudo[2729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
May 28 08:45:37 rivo sudo[2729]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:37 rivo sudo[2729]: pam_unix(sudo:session): session closed for user root
May 28 08:45:37 rivo volumio[3120]: info: MPD Permissions set
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo sudo[2732]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
May 28 08:45:37 rivo sudo[2732]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:37 rivo systemd[1]: Stopping Volumio Qobuz Connect Service...
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 28 08:45:37 rivo qobuz-connect[27930]: 20250528 08:45:37.573 [27930.27930] INFO SampleApp: Stopping Local configuration server
May 28 08:45:37 rivo qobuz-connect[27930]: 20250528 08:45:37.584 [27930.27930] INFO SampleApp: shat down connection on UNIX socket
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:37 rivo volumio[3120]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
May 28 08:45:37 rivo volumio[3120]: info: QobuzConnect: setDeactiveState invoked
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:37 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:37 rivo volumio[3120]: info: Starting Shairport Sync
May 28 08:45:37 rivo systemd[1]: qobuz-connect.service: Succeeded.
May 28 08:45:37 rivo systemd[1]: Stopped Volumio Qobuz Connect Service.
May 28 08:45:37 rivo systemd[1]: Started Volumio Qobuz Connect Service.
May 28 08:45:37 rivo sudo[2732]: pam_unix(sudo:session): session closed for user root
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
May 28 08:45:37 rivo sudo[2742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 28 08:45:37 rivo sudo[2742]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:37 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 28 08:45:37 rivo systemd[1]: shairport-sync.service: Succeeded.
May 28 08:45:37 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 28 08:45:37 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 28 08:45:37 rivo volumio[3120]: info: Not Reporting Auto name since its the default one
May 28 08:45:37 rivo sudo[2742]: pam_unix(sudo:session): session closed for user root
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:37 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
May 28 08:45:37 rivo volumio[3120]: info: Executing endpoint qc_getconfig
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
May 28 08:45:37 rivo volumio[3120]: info: Shairport-Sync Started
May 28 08:45:37 rivo qobuz-connect[2741]: 20250528 08:45:37.838 [2741.2741] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
May 28 08:45:37 rivo volumio[3120]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
May 28 08:45:37 rivo volumio[3120]: info: QobuzConnect: QOBUZ Connect daemon connected
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
May 28 08:45:37 rivo qobuz-connect[2741]: 20250528 08:45:37.868 [2741.2741] INFO VolumeManager: [0xac76f9c0]: Setting new playback volume: 75
May 28 08:45:37 rivo qobuz-connect[2741]: 20250528 08:45:37.868 [2741.2741] INFO VolumeManager: [0xac76f9c0]: Setting new mute state: 0
May 28 08:45:37 rivo qobuz-connect[2741]: 20250528 08:45:37.868 [2741.2741] INFO QobuzConnect: [0xac770390]: Client initialized!
May 28 08:45:37 rivo qobuz-connect[2741]: 20250528 08:45:37.868 [2741.2741] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp
May 28 08:45:37 rivo qobuz-connect[2741]: 20250528 08:45:37.881 [2741.2741] INFO LocalConfigManager: [0xac76f2a0]: Starting Local Configuration server
May 28 08:45:37 rivo qobuz-connect[2741]: 20250528 08:45:37.881 [2741.2741] INFO SampleApp: Starting Local configuration server
May 28 08:45:37 rivo qobuz-connect[2741]: 20250528 08:45:37.882 [2741.2741] INFO SampleApp: Connected to UNIX socket client 0xac764ed8
May 28 08:45:37 rivo volumio[3120]: No protocol specified
May 28 08:45:37 rivo volumio[3120]: xcb_connection_has_error() returned true
May 28 08:45:37 rivo sudo[2761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
May 28 08:45:37 rivo sudo[2761]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:37 rivo qobuz-connect[2741]: 20250528 08:45:37.989 [2741.2741] INFO SampleApp: Playback volume changed: 75
May 28 08:45:37 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:37 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:38 rivo sudo[2761]: pam_unix(sudo:session): session closed for user root
May 28 08:45:38 rivo sudo[2763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
May 28 08:45:38 rivo sudo[2763]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:38 rivo systemd[1]: Stopping RAAT DAEMON...
May 28 08:45:38 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
May 28 08:45:38 rivo systemd[1]: raat-daemon.service: Succeeded.
May 28 08:45:38 rivo systemd[1]: Stopped RAAT DAEMON.
May 28 08:45:38 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:38 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:45:38 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
May 28 08:45:38 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
May 28 08:45:38 rivo systemd[1]: Started RAAT DAEMON.
May 28 08:45:38 rivo sudo[2763]: pam_unix(sudo:session): session closed for user root
May 28 08:45:38 rivo volumio[3120]: info: Raat Daemon started successfully
May 28 08:45:38 rivo volumio[3120]: info: Executing endpoint restartRAATSocket
May 28 08:45:38 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
May 28 08:45:38 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:38 rivo volumio[3120]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13
May 28 08:45:39 rivo mpd[2730]: May 28 08:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 28 08:45:39 rivo systemd[1]: Started Music Player Daemon.
May 28 08:45:39 rivo sudo[2698]: pam_unix(sudo:session): session closed for user root
May 28 08:45:39 rivo volumio[3120]: error: updateQueue error: null
May 28 08:45:40 rivo volumio[3120]: info: TidalConnect service stoped!
May 28 08:45:40 rivo volumio[3120]: info: TidalConnect service stoped!
May 28 08:45:40 rivo volumio[3120]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
May 28 08:45:40 rivo volumio[3120]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
May 28 08:45:40 rivo sudo[2789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
May 28 08:45:40 rivo sudo[2789]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:45:40 rivo systemd[1]: Started Volumio Tidal Connect Service.
May 28 08:45:40 rivo sudo[2789]: pam_unix(sudo:session): session closed for user root
May 28 08:45:40 rivo volumio[3120]: info: RAAT: Requesting Headphone Status
May 28 08:45:40 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus
May 28 08:45:40 rivo volumio[3120]: info: Executing endpoint tc_getconfig
May 28 08:45:40 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
May 28 08:45:40 rivo vtcs[2791]: STARTING TidalConnect services, version: 1.4.0.34
May 28 08:45:40 rivo volumio[3120]: info: MCU Signalled Headphone Mode Disabled
May 28 08:45:40 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState
May 28 08:45:40 rivo volumio[3120]: info: Reporting Headphone State: false
May 28 08:45:40 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:40 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 08:45:40 rivo volumio[3120]: info: Updating RAAT Signal Path
May 28 08:45:41 rivo vtcs[2791]: STARTED TidalConnect services.
May 28 08:45:41 rivo volumio[3120]: info: Executing endpoint tc_connect
May 28 08:45:41 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
May 28 08:45:41 rivo volumio[3120]: info: Connecting to TidalConnect
May 28 08:45:41 rivo volumio[3120]: info: CoreCommandRouter::servicePushState
May 28 08:45:41 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:41 rivo volumio[3120]: verbose: STATE SERVICE {"status":"pause","service":"tidalconnect","title":"23-31 8000 Hz Sinus 60 Sekunden - 4 db - linker Kanal","artist":"Doug van Roegelsnap","album":"Audio Test CD - 2.Ausgabe","albumart":"https://resources.tidal.com/images/84d1c4a3/f4a0/4a98/80ec/c2248047d160/1280x1280.jpg","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"flac","seek":0,"duration":68,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":1411200,"channels":2,"random":false,"repeat":false,"repeatSingle":false,"stream":false,"repeatMode":"all"}
May 28 08:45:41 rivo volumio[3120]: verbose: CURRENT POSITION 0
May 28 08:45:41 rivo volumio[3120]: info: CoreStateMachine::syncState stateService pause
May 28 08:45:41 rivo volumio[3120]: info: CoreStateMachine::syncState currentStatus stop
May 28 08:45:41 rivo volumio[3120]: info: CoreStateMachine::pushState
May 28 08:45:41 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:41 rivo volumio[3120]: info: CoreCommandRouter::volumioPushState
May 28 08:45:41 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:41 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:41 rivo volumio[3120]: info: MRS: Pushing multiroomSync output update for this device
May 28 08:45:41 rivo volumio[3120]: info: MRS: Pushing multiroomSync output
May 28 08:45:41 rivo volumio[3120]: info: CoreCommandRouter::servicePushState
May 28 08:45:41 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:41 rivo volumio[3120]: verbose: STATE SERVICE {"status":"pause","service":"tidalconnect","title":"23-31 8000 Hz Sinus 60 Sekunden - 4 db - linker Kanal","artist":"Doug van Roegelsnap","album":"Audio Test CD - 2.Ausgabe","albumart":"https://resources.tidal.com/images/84d1c4a3/f4a0/4a98/80ec/c2248047d160/1280x1280.jpg","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"flac","seek":0,"duration":68,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":1411200,"channels":2,"random":false,"repeat":false,"repeatSingle":false,"stream":false,"repeatMode":"all"}
May 28 08:45:41 rivo volumio[3120]: verbose: CURRENT POSITION 0
May 28 08:45:41 rivo volumio[3120]: info: CoreStateMachine::syncState stateService pause
May 28 08:45:41 rivo volumio[3120]: info: CoreStateMachine::syncState currentStatus stop
May 28 08:45:41 rivo volumio[3120]: info: CoreStateMachine::pushState
May 28 08:45:41 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:41 rivo volumio[3120]: info: CoreCommandRouter::volumioPushState
May 28 08:45:41 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:41 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:41 rivo volumio[3120]: info: MRS: Pushing multiroomSync output update for this device
May 28 08:45:41 rivo volumio[3120]: info: MRS: Pushing multiroomSync output
May 28 08:45:41 rivo volumio[3120]: info: Updating RAAT Signal Path
May 28 08:45:41 rivo volumio[3120]: info: Updating RAAT Signal Path
May 28 08:45:41 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:45:43 rivo volumio[3120]: info: TidalConnect service started!
May 28 08:45:45 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:45:47 rivo go-librespot[32138]: time="2025-05-28T08:45:47+02:00" level=trace msg="sent dealer ping"
May 28 08:45:47 rivo go-librespot[32138]: time="2025-05-28T08:45:47+02:00" level=trace msg="received dealer pong"
May 28 08:45:49 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:45:53 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:45:57 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 28 08:45:57 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 28 08:45:57 rivo volumio[3120]: info: Discovery: Getting this device information
May 28 08:45:57 rivo volumio[3120]: info: CoreCommandRouter::volumioGetState
May 28 08:45:57 rivo volumio[3120]: info: CorePlayQueue::getTrack 0
May 28 08:45:57 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 28 08:45:57 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:46:00 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:46:01 rivo volumio[3120]: info: Disabling MyMusic plugin upnp
May 28 08:46:01 rivo sudo[2861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
May 28 08:46:01 rivo sudo[2861]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 28 08:46:01 rivo systemd[1]: Stopping UPnP Renderer front-end to MPD...
May 28 08:46:01 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:46:01 rivo volumio[3120]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 28 08:46:01 rivo volumio[3120]: error: Upnp client error: Error: This socket has been ended by the other party
May 28 08:46:05 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:46:09 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:46:13 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:46:17 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:46:17 rivo go-librespot[32138]: time="2025-05-28T08:46:17+02:00" level=trace msg="received accesspoint ping"
May 28 08:46:17 rivo go-librespot[32138]: time="2025-05-28T08:46:17+02:00" level=trace msg="received accesspoint pong ack"
May 28 08:46:17 rivo go-librespot[32138]: time="2025-05-28T08:46:17+02:00" level=trace msg="sent dealer ping"
May 28 08:46:17 rivo go-librespot[32138]: time="2025-05-28T08:46:17+02:00" level=trace msg="received dealer pong"
May 28 08:46:20 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 08:46:22 rivo volumio[3120]: info: Enabling MyMusic plugin upnp
May 28 08:46:22 rivo volumio[3120]: info: Enabling plugin upnp
May 28 08:46:22 rivo volumio[3120]: info: Loading plugin "upnp"...
May 28 08:46:22 rivo volumio[3120]: info: [1748414782880] Starting Upmpd Daemon
May 28 08:46:22 rivo volumio[3120]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 28 08:46:22 rivo volumio[3120]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 28 08:46:22 rivo volumio[3120]: Error: listen EADDRINUSE: address already in use :::6599
May 28 08:46:22 rivo volumio[3120]: at Server.setupListenHandle [as _listen2] (net.js:1331:16)
May 28 08:46:22 rivo volumio[3120]: at listenInCluster (net.js:1379:12)
May 28 08:46:22 rivo volumio[3120]: at Server.listen (net.js:1465:7)
May 28 08:46:22 rivo volumio[3120]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
May 28 08:46:22 rivo volumio[3120]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
May 28 08:46:22 rivo volumio[3120]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
May 28 08:46:22 rivo volumio[3120]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
May 28 08:46:22 rivo volumio[3120]: at processTicksAndRejections (internal/process/task_queues.js:77:11) {
May 28 08:46:22 rivo volumio[3120]: code: 'EADDRINUSE',
May 28 08:46:22 rivo volumio[3120]: errno: -98,
May 28 08:46:22 rivo volumio[3120]: syscall: 'listen',
May 28 08:46:22 rivo volumio[3120]: address: '::',
May 28 08:46:22 rivo volumio[3120]: port: 6599
May 28 08:46:22 rivo volumio[3120]: }
May 28 08:46:22 rivo volumio[3120]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 28 08:46:23 rivo sudo[2956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-28 08:45
May 28 08:46:23 rivo sudo[2956]: 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="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivo"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 06:24:39 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Rivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo"
VOLUMIO_HASH="c8a59422b1bfedffc72f72cef58ad20b"