Jan 28 17:32:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:02 volumio sudo[5472]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 17:32:02 volumio sudo[5472]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:02 volumio sudo[5474]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 17:32:02 volumio sudo[5474]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:02 volumio sudo[5472]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:02 volumio sudo[5474]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:02 volumio volumio[4638]: verbose: New Socket.io Connection to 192.168.2.102 from 192.168.2.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:02 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:32:02 volumio volumio[4638]: info: Received Get System Info Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 17:32:02 volumio volumio[4638]: info: Discovery: Getting this device information Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:02 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:02 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::volumioGetVisibleSources Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:02 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:02 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 28 17:32:02 volumio volumio[4638]: info: Received Get System Info Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 17:32:02 volumio volumio[4638]: info: Discovery: Getting this device information Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:02 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:02 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:32:02 volumio volumio[4638]: info: Listing playlists Jan 28 17:32:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 28 17:32:05 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:07 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 28 17:32:09 volumio volumio[4638]: info: CoreCommandRouter::Close All Modals sent Jan 28 17:32:09 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted Jan 28 17:32:09 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:10 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jan 28 17:32:10 volumio volumio[4638]: info: MyVolumio login type: Token Jan 28 17:32:11 volumio volumio[4638]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jan 28 17:32:11 volumio volumio[4638]: info: MyVolumio token set successfully Jan 28 17:32:11 volumio volumio[4638]: info: MYVOLUMIO: Adding device Jan 28 17:32:11 volumio volumio[4638]: info: MYVOLUMIO: Evaluating Server Jan 28 17:32:11 volumio volumio[4638]: info: MyVolumio Plan changed: premium Jan 28 17:32:11 volumio volumio[4638]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jan 28 17:32:11 volumio volumio[4638]: info: Removing browser output: myVolumio user plan is not superstar Jan 28 17:32:11 volumio volumio[4638]: info: Removing audio output: Jan 28 17:32:11 volumio volumio[4638]: info: MYVOLUMIO: Adding device Jan 28 17:32:11 volumio volumio[4638]: info: MYVOLUMIO: Evaluating Server Jan 28 17:32:11 volumio volumio[4638]: info: Remote config written successfully Jan 28 17:32:11 volumio volumio[4638]: info: Starting Tunnel 1 Jan 28 17:32:11 volumio volumio[4638]: info: Starting Tunnel Connection Checker Jan 28 17:32:11 volumio volumio[4638]: info: MYVolumio Device enabled Jan 28 17:32:11 volumio volumio[4638]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jan 28 17:32:11 volumio volumio[4638]: info: MyVolumio status changed Jan 28 17:32:11 volumio volumio[4638]: info: Streaming services startup Jan 28 17:32:11 volumio volumio[4638]: info: Starting Streaming Daemon Jan 28 17:32:12 volumio sudo[5544]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 28 17:32:12 volumio sudo[5544]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:12 volumio volumio[4638]: info: Setting Geolocation for MyVolumio to eu8 Jan 28 17:32:12 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:12 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:12 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:12 volumio volumio[4638]: error: [MyVolumio PluginManager] Could not read cache file: ENOENT: no such file or directory, open '/data/myvolumio/cache.data' Jan 28 17:32:12 volumio sudo[5544]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:12 volumio volumio[4638]: error: Cannot start Volumio Streaming Daemon Jan 28 17:32:12 volumio volumio[4638]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 28 17:32:12 volumio volumio[4638]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 28 17:32:12 volumio volumio[4638]: info: Setting Geolocation for MyVolumio to eu5 Jan 28 17:32:12 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:12 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:12 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:12 volumio volumio[4638]: info: Successfully Added MyVolumio device Jan 28 17:32:12 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 28 17:32:12 volumio volumio[4638]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jan 28 17:32:12 volumio volumio[4638]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Jan 28 17:32:12 volumio volumio[4638]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jan 28 17:32:14 volumio sudo[5550]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jan 28 17:32:14 volumio sudo[5550]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:14 volumio sudo[5550]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:14 volumio volumio[4638]: info: MRS: MultiRoom plugin initialized Jan 28 17:32:14 volumio volumio[4638]: info: MRS: STOPPING SNAPCLIENT Jan 28 17:32:14 volumio volumio[4638]: info: MRS: Snap server stop Jan 28 17:32:14 volumio volumio[4638]: info: MRS: STOPPING volumioStreaming Jan 28 17:32:14 volumio sudo[5567]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jan 28 17:32:14 volumio sudo[5567]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:14 volumio sudo[5569]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jan 28 17:32:14 volumio sudo[5569]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:14 volumio sudo[5574]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jan 28 17:32:14 volumio sudo[5574]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:14 volumio sudo[5571]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jan 28 17:32:14 volumio sudo[5571]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:14 volumio sudo[5574]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jan 28 17:32:14 volumio sudo[5567]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jan 28 17:32:14 volumio sudo[5569]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:14 volumio sudo[5571]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Jan 28 17:32:14 volumio volumio[4638]: info: Preparing to generate the ALSA configuration file Jan 28 17:32:14 volumio volumio[4638]: info: Updating MyVolumio device info Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:14 volumio volumio[4638]: info: Updating MyVolumio device info Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jan 28 17:32:14 volumio volumio[4638]: info: Successfully Added MyVolumio device Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 28 17:32:14 volumio volumio[4638]: info: Received Get System Info Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 17:32:14 volumio volumio[4638]: info: Discovery: Getting this device information Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:14 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:14 volumio volumio[4638]: info: MRS: Removed streaming files Jan 28 17:32:14 volumio volumio[4638]: info: MRS: volumioStreaming STOPPED Jan 28 17:32:14 volumio volumio[4638]: info: MRS: SNAPSERVER STOPPED Jan 28 17:32:14 volumio volumio[4638]: info: MRS: SNAPCLIENT STOPPED Jan 28 17:32:14 volumio volumio[4638]: info: Asound.conf file unchanged, so no further update is needed Jan 28 17:32:14 volumio volumio[4638]: info: Output device has changed, restarting MPD Jan 28 17:32:14 volumio volumio[4638]: info: Output device has changed, restarting Shairport Sync Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:14 volumio sudo[5580]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 28 17:32:14 volumio sudo[5580]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:14 volumio sudo[5580]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:14 volumio volumio[4638]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 28 17:32:14 volumio sudo[5582]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 28 17:32:14 volumio volumio[4638]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 28 17:32:14 volumio sudo[5582]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Jan 28 17:32:14 volumio volumio[4638]: ------------------------------------ BT MESSAGE: [FUNC] onStart Jan 28 17:32:14 volumio volumio[4638]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Jan 28 17:32:14 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 28 17:32:14 volumio volumio[4638]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Jan 28 17:32:14 volumio volumio[4638]: ------------------------------------ BT MESSAGE: [metaCache] Created directory: /tmp/bluetooth-cache/ Jan 28 17:32:14 volumio volumio[4638]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Jan 28 17:32:14 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 28 17:32:14 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 28 17:32:14 volumio systemd[1]: mpd.service: Consumed 1.111s CPU time. Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jan 28 17:32:14 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 28 17:32:14 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 28 17:32:14 volumio volumio[4638]: info: MRS: Pushing multiroomSync output for this device Jan 28 17:32:14 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 28 17:32:14 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:32:14 volumio volumio[4638]: info: Adding audio output: Jan 28 17:32:14 volumio volumio[4638]: info: Adding audio output: Jan 28 17:32:14 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 28 17:32:14 volumio volumio[4638]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 28 17:32:14 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Jan 28 17:32:14 volumio volumio[4638]: info: Adding METAVOLUMIO REST API Endpoints Jan 28 17:32:14 volumio volumio[4638]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jan 28 17:32:14 volumio volumio[4638]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jan 28 17:32:14 volumio volumio[4638]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jan 28 17:32:14 volumio volumio[4638]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Jan 28 17:32:14 volumio volumio[4638]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Jan 28 17:32:14 volumio volumio[4638]: info: Preparing CD Folders Jan 28 17:32:14 volumio volumio[4638]: info: Adding CD REST API Endpoints Jan 28 17:32:14 volumio volumio[4638]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jan 28 17:32:14 volumio volumio[4638]: info: Starting UDEV Watcher for CD Jan 28 17:32:14 volumio volumio[4638]: info: Detecting CD presence with UDEV Jan 28 17:32:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jan 28 17:32:14 volumio sudo[5595]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 28 17:32:14 volumio sudo[5595]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 28 17:32:14 volumio sudo[5595]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:15 volumio mpd[5603]: 2026-01-28T17:32:15 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 28 17:32:15 volumio systemd[1]: Started mpd.service - Music Player Daemon. Jan 28 17:32:15 volumio sudo[5582]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:19 volumio volumio[4638]: warn: [cd-plugin] cdspeedctl: device or media not ready Jan 28 17:32:19 volumio volumio[4638]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Jan 28 17:32:19 volumio volumio[4638]: info: Adding inputs REST Endpoints Jan 28 17:32:19 volumio volumio[4638]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jan 28 17:32:19 volumio volumio[4638]: info: Scanning Audio Inputs Jan 28 17:32:19 volumio volumio[4638]: info: Checking against Known Cards name Jan 28 17:32:19 volumio volumio[4638]: info: Adding Server instance for streaming Jan 28 17:32:19 volumio volumio[4638]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Jan 28 17:32:19 volumio volumio[4638]: error: Hi Res Audio Failed Login: Missing Login Data Jan 28 17:32:19 volumio volumio[4638]: info: Adding HIGHRESAUDIO REST API Endpoints Jan 28 17:32:19 volumio volumio[4638]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jan 28 17:32:19 volumio volumio[4638]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Jan 28 17:32:19 volumio volumio[4638]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Jan 28 17:32:19 volumio volumio[4638]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Jan 28 17:32:19 volumio volumio[4638]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Jan 28 17:32:19 volumio volumio[4638]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:19 volumio volumio[4638]: info: QobuzConnect: Starting Qobuz Connect socket and service Jan 28 17:32:19 volumio sudo[5629]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 28 17:32:19 volumio sudo[5629]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:19 volumio volumio[4638]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Jan 28 17:32:19 volumio volumio[4638]: info: Adding TIDAL REST API Endpoints Jan 28 17:32:19 volumio volumio[4638]: info: Stopping AccessToken refresher cron for QOBUZ Jan 28 17:32:19 volumio sudo[5636]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 28 17:32:19 volumio sudo[5636]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:19 volumio sudo[5629]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:19 volumio sudo[5636]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:19 volumio volumio[4638]: info: AccessToken refresher cron started for QOBUZ Jan 28 17:32:19 volumio volumio[4638]: info: Adding QOBUZ REST API Endpoints Jan 28 17:32:19 volumio sudo[5639]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 28 17:32:19 volumio sudo[5639]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:19 volumio volumio[4638]: info: MRS: Getting audio outputs on start Jan 28 17:32:19 volumio volumio[4638]: info: MRS: Requesting all other devices output Jan 28 17:32:19 volumio volumio[4638]: info: Successfully Updated MyVolumio device Jan 28 17:32:19 volumio volumio[4638]: info: Successfully Updated MyVolumio device Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 28 17:32:19 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jan 28 17:32:19 volumio volumio[4638]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 28 17:32:19 volumio sudo[5639]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:19 volumio volumio[4638]: info: Received Get System Version Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 28 17:32:19 volumio volumio[4638]: info: Received Get System Info Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 17:32:19 volumio volumio[4638]: info: Discovery: Getting this device information Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:19 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 17:32:19 volumio volumio[4638]: ------------------------------------ BT MESSAGE: Failed to power on adapter: Jan 28 17:32:19 volumio volumio[4638]: info: MPD Permissions set Jan 28 17:32:19 volumio sudo[5643]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jan 28 17:32:19 volumio sudo[5643]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 28 17:32:19 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:19 volumio systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Jan 28 17:32:20 volumio sudo[5643]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:20 volumio volumiobt[5661]: INFO [BTSTART] Ensuring Bluetooth directory exists... Jan 28 17:32:20 volumio volumio[4638]: error: updateQueue error: null Jan 28 17:32:20 volumio volumio[4638]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::volumioStop Jan 28 17:32:20 volumio volumio[4638]: info: CoreStateMachine::stop Jan 28 17:32:20 volumio volumio[4638]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 17:32:20 volumio volumio[4638]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart Jan 28 17:32:20 volumio volumio[4638]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 17:32:20 volumio sudo[5663]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Jan 28 17:32:20 volumio sudo[5663]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:20 volumio sudo[5663]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:20 volumio sudo[5666]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Jan 28 17:32:20 volumio sudo[5666]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:20 volumio sudo[5666]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:20 volumio volumiobt[5668]: INFO [BTSTART] Powering on Bluetooth if needed... Jan 28 17:32:20 volumio volumio[4638]: info: Executing endpoint qc_getconfig Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 28 17:32:20 volumio qobuz-connect[5641]: 20260128 17:32:20.117 [5641.5641] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 28 17:32:20 volumio volumio[4638]: info: Starting Shairport Sync Jan 28 17:32:20 volumio volumiobt[5674]: No default controller available Jan 28 17:32:20 volumio sudo[5676]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jan 28 17:32:20 volumio sudo[5676]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:20 volumio sudo[5679]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 28 17:32:20 volumio sudo[5679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:20 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jan 28 17:32:20 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Jan 28 17:32:20 volumio qobuz-connect[5641]: 20260128 17:32:20.180 [5641.5641] INFO VolumeManager: [0x55dcfba96300]: Setting new playback volume: 75 Jan 28 17:32:20 volumio qobuz-connect[5641]: 20260128 17:32:20.181 [5641.5641] INFO VolumeManager: [0x55dcfba96300]: Setting new mute state: 0 Jan 28 17:32:20 volumio qobuz-connect[5641]: 20260128 17:32:20.181 [5641.5641] INFO QobuzConnect: [0x55dcfba97520]: Client initialized! Jan 28 17:32:20 volumio qobuz-connect[5641]: 20260128 17:32:20.181 [5641.5641] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Jan 28 17:32:20 volumio qobuz-connect[5641]: 20260128 17:32:20.191 [5641.5641] INFO LocalConfigManager: [0x55dcfba955f0]: Starting Local Configuration server Jan 28 17:32:20 volumio qobuz-connect[5641]: 20260128 17:32:20.191 [5641.5641] INFO SampleApp: Starting Local configuration server Jan 28 17:32:20 volumio qobuz-connect[5641]: 20260128 17:32:20.191 [5641.5641] INFO SampleApp: Connected to UNIX socket client 0x55dcfba6bbb0 Jan 28 17:32:20 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Jan 28 17:32:20 volumio sudo[5676]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:20 volumio volumio[4638]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 28 17:32:20 volumio volumio[4638]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 28 17:32:20 volumio volumio[4638]: info: MRS: Found cast device: Google-Nest-Hub-0036cabf77239750008405c1cb1fc212 Jan 28 17:32:20 volumio volumio[4638]: info: Adding audio output: Jan 28 17:32:20 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 28 17:32:20 volumio volumio[4638]: info: MRS: Found cast device: Google-Nest-Hub-6e558941bf410d009a7f6c26e11c55d3 Jan 28 17:32:20 volumio volumio[4638]: info: Adding audio output: Jan 28 17:32:20 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 28 17:32:20 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 28 17:32:20 volumio systemd[1]: shairport-sync.service: Consumed 3.416s CPU time. Jan 28 17:32:20 volumio autossh[5686]: port set to 0, monitoring disabled Jan 28 17:32:20 volumio autossh[5686]: starting ssh (count 1) Jan 28 17:32:20 volumio autossh[5686]: ssh child pid is 5689 Jan 28 17:32:20 volumio volumio[4638]: info: Preparing to generate the ALSA configuration file Jan 28 17:32:20 volumio volumio[4638]: info: Remote SSH Started Jan 28 17:32:20 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 28 17:32:20 volumio qobuz-connect[5641]: 20260128 17:32:20.266 [5641.5641] INFO SampleApp: Playback volume changed: 75 Jan 28 17:32:20 volumio sudo[5679]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:20 volumio volumiossh-tunnel[5689]: Warning: Permanently added '[eu5.myvolumio.org]:2222' (RSA) to the list of known hosts. Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:20 volumio volumio[4638]: info: Shairport-Sync Started Jan 28 17:32:20 volumio volumio[4638]: info: MRS: Found cast device: NEO_U22-XJ-3b3f8e2301f06239e9199d0ca8eeeb98 Jan 28 17:32:20 volumio volumio[4638]: info: Adding audio output: Jan 28 17:32:20 volumio volumio[4638]: info: MRS: Found cast device: Google-Cast-Group-fd42dc1bdae54bcaa7ab850c5be1b0b0 Jan 28 17:32:20 volumio volumio[4638]: info: Adding audio output: Jan 28 17:32:20 volumio volumio[4638]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jan 28 17:32:20 volumio volumio[4638]: info: Asound.conf file unchanged, so no further update is needed Jan 28 17:32:20 volumio volumio[4638]: info: Output device has changed, restarting MPD Jan 28 17:32:20 volumio volumio[4638]: info: Output device has changed, restarting Shairport Sync Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:20 volumio sudo[5707]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 28 17:32:20 volumio sudo[5707]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:20 volumio sudo[5709]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 28 17:32:20 volumio sudo[5709]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:20 volumio sudo[5707]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:20 volumio volumio[4638]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 28 17:32:20 volumio volumio[4638]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:20 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 28 17:32:20 volumio volumio[4638]: info: QobuzConnect: setDeactiveState invoked Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:20 volumio volumio[4638]: info: Preparing to generate the ALSA configuration file Jan 28 17:32:20 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 28 17:32:20 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 28 17:32:20 volumio systemd[1]: mpd.service: Consumed 1.123s CPU time. Jan 28 17:32:20 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 28 17:32:20 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 28 17:32:20 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:20 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 28 17:32:20 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 28 17:32:20 volumio volumio[4638]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 28 17:32:20 volumio volumio[4638]: info: Reading ALSA contributions from plugins. Jan 28 17:32:20 volumio volumio[4638]: info: MPD Permissions set Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:20 volumio sudo[5725]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 28 17:32:20 volumio sudo[5725]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:20 volumio sudo[5724]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 28 17:32:20 volumio sudo[5724]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 28 17:32:20 volumio sudo[5725]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:20 volumio sudo[5724]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:20 volumio volumio[4638]: info: Starting Shairport Sync Jan 28 17:32:20 volumio sudo[5736]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 28 17:32:20 volumio sudo[5736]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:20 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jan 28 17:32:20 volumio qobuz-connect[5641]: 20260128 17:32:20.748 [5641.5641] INFO SampleApp: Stopping Local configuration server Jan 28 17:32:20 volumio sudo[5741]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 28 17:32:20 volumio volumio[4638]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.rDRBmnRicNe9IFSqzqbHi9PA03s2.00d479372362e622324f723a6f9709e0.state.status' Jan 28 17:32:20 volumio sudo[5741]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:20 volumio volumio[4638]: info: Asound.conf file written Jan 28 17:32:20 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 28 17:32:20 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 28 17:32:20 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 28 17:32:20 volumio sudo[5745]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 28 17:32:20 volumio sudo[5745]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:20 volumio sudo[5745]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:20 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 28 17:32:20 volumio sudo[5741]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:20 volumio volumio[4638]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 28 17:32:20 volumio volumio[4638]: No state is present for card Audio Jan 28 17:32:20 volumio volumio[4638]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 28 17:32:20 volumio volumio[4638]: Found hardware: "HdmiLpeAudio" "" "" "" "" Jan 28 17:32:20 volumio volumio[4638]: Hardware is initialized using a generic method Jan 28 17:32:20 volumio volumio[4638]: No state is present for card Audio Jan 28 17:32:20 volumio volumio[4638]: No state is present for card D2MINI Jan 28 17:32:20 volumio volumio[4638]: Found hardware: "USB-Audio" "USB Mixer" "USB262a:9023" "" "" Jan 28 17:32:20 volumio volumio[4638]: Hardware is initialized using a generic method Jan 28 17:32:20 volumio volumio[4638]: No state is present for card D2MINI Jan 28 17:32:20 volumio volumio[4638]: info: Output device has changed, restarting MPD Jan 28 17:32:20 volumio volumio[4638]: info: Output device has changed, restarting Shairport Sync Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:20 volumio sudo[5767]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 28 17:32:20 volumio sudo[5767]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:20 volumio sudo[5753]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 28 17:32:20 volumio sudo[5753]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:20 volumio sudo[5753]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:21 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 28 17:32:21 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 28 17:32:21 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 28 17:32:21 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 28 17:32:21 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 28 17:32:21 volumio volumio[4638]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 28 17:32:21 volumio volumio[4638]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:21 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 28 17:32:21 volumio volumio[4638]: info: QobuzConnect: setDeactiveState invoked Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:21 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:21 volumio volumio[4638]: info: MPD Permissions set Jan 28 17:32:21 volumio volumio[4638]: info: Shairport-Sync Started Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:21 volumio sudo[5784]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 28 17:32:21 volumio sudo[5784]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 28 17:32:21 volumio sudo[5784]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:32:21 volumio sudo[5776]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 28 17:32:21 volumio sudo[5776]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 28 17:32:21 volumio volumiobt[5795]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Jan 28 17:32:21 volumio sudo[5793]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 28 17:32:21 volumio sudo[5793]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:21 volumio volumio[4638]: info: Starting Shairport Sync Jan 28 17:32:21 volumio sudo[5776]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:21 volumio volumiobt[5797]: [165B blob data] Jan 28 17:32:21 volumio volumiobt[5797]: [bluetoothctl]> discoverable on Jan 28 17:32:21 volumio volumiobt[5797]: No default controller available Jan 28 17:32:21 volumio volumiobt[5797]: [bluetoothctl]> pairable on Jan 28 17:32:21 volumio volumiobt[5797]: No default controller available Jan 28 17:32:21 volumio volumiobt[5797]: [bluetoothctl]> Jan 28 17:32:21 volumio volumiobt[5802]: INFO [BTSTART] Registering Bluetooth agent... Jan 28 17:32:21 volumio sudo[5801]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 28 17:32:21 volumio sudo[5801]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:21 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 28 17:32:21 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 28 17:32:21 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 28 17:32:21 volumio volumiobt[5805]: No agent is registered Jan 28 17:32:21 volumio volumiobt[5807]: INFO [BTSTART] Agent registered successfully. Jan 28 17:32:21 volumio volumiobt[5808]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Jan 28 17:32:21 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 28 17:32:21 volumio sudo[5801]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:21 volumio volumio[4638]: info: Shairport-Sync Started Jan 28 17:32:21 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:21 volumio volumiobt[5809]: INFO:a2dp-agent:Connecting to system bus. Jan 28 17:32:21 volumio volumiobt[5809]: ERROR:a2dp-agent:No Bluetooth adapter found: Bluetooth adapter not found Jan 28 17:32:22 volumio volumiobt[5826]: INFO [BTSTART] Disconnecting all Bluetooth devices... Jan 28 17:32:22 volumio volumiobt[5831]: INFO [BTSTART] Unregistering Bluetooth agent... Jan 28 17:32:22 volumio volumiobt[5832]: No agent is registered Jan 28 17:32:22 volumio volumiobt[5833]: INFO [BTSTART] Stopping bluealsa-aplay (if any)... Jan 28 17:32:22 volumio volumiobt[5835]: INFO [BTSTART] Stopping A2DP agent (a2dp-agent)... Jan 28 17:32:22 volumio systemd[1]: volumiobt.service: Deactivated successfully. Jan 28 17:32:22 volumio qobuz-connect[5641]: 20260128 17:32:22.196 [5641.5641] INFO SampleApp: shat down connection on UNIX socket Jan 28 17:32:22 volumio volumio[4638]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jan 28 17:32:22 volumio volumio[4638]: info: QobuzConnect: setDeactiveState invoked Jan 28 17:32:22 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:22 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Jan 28 17:32:22 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jan 28 17:32:22 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jan 28 17:32:22 volumio sudo[5736]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:22 volumio sudo[5793]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:22 volumio mpd[5799]: 2026-01-28T17:32:22 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 28 17:32:22 volumio volumio[4638]: info: Executing endpoint qc_getconfig Jan 28 17:32:22 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 28 17:32:22 volumio systemd[1]: Started mpd.service - Music Player Daemon. Jan 28 17:32:22 volumio sudo[5767]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:22 volumio sudo[5709]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:22 volumio qobuz-connect[5837]: 20260128 17:32:22.285 [5837.5837] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 28 17:32:22 volumio qobuz-connect[5837]: 20260128 17:32:22.288 [5837.5837] INFO VolumeManager: [0x563a54268300]: Setting new playback volume: 75 Jan 28 17:32:22 volumio qobuz-connect[5837]: 20260128 17:32:22.289 [5837.5837] INFO VolumeManager: [0x563a54268300]: Setting new mute state: 0 Jan 28 17:32:22 volumio qobuz-connect[5837]: 20260128 17:32:22.289 [5837.5837] INFO QobuzConnect: [0x563a54269520]: Client initialized! Jan 28 17:32:22 volumio qobuz-connect[5837]: 20260128 17:32:22.289 [5837.5837] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Jan 28 17:32:22 volumio qobuz-connect[5837]: 20260128 17:32:22.303 [5837.5837] INFO LocalConfigManager: [0x563a542675f0]: Starting Local Configuration server Jan 28 17:32:22 volumio qobuz-connect[5837]: 20260128 17:32:22.303 [5837.5837] INFO SampleApp: Starting Local configuration server Jan 28 17:32:22 volumio qobuz-connect[5837]: 20260128 17:32:22.304 [5837.5837] INFO SampleApp: Connected to UNIX socket client 0x563a5423dbb0 Jan 28 17:32:22 volumio volumio[4638]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 28 17:32:22 volumio volumio[4638]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 28 17:32:22 volumio volumio[4638]: error: MPD error: The expression evaluated to a falsy value: Jan 28 17:32:22 volumio volumio[4638]: assert.ok(self.idling) Jan 28 17:32:22 volumio volumio[4638]: error: The expression evaluated to a falsy value: Jan 28 17:32:22 volumio volumio[4638]: assert.ok(self.idling) Jan 28 17:32:22 volumio volumio[4638]: error: updateQueue error: null Jan 28 17:32:22 volumio qobuz-connect[5837]: 20260128 17:32:22.435 [5837.5837] INFO SampleApp: Playback volume changed: 75 Jan 28 17:32:22 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:22 volumio volumio[4638]: info: TidalConnect service stoped! Jan 28 17:32:22 volumio volumio[4638]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 28 17:32:22 volumio volumio[4638]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 28 17:32:22 volumio sudo[5855]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 28 17:32:22 volumio sudo[5855]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:22 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jan 28 17:32:22 volumio sudo[5855]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:23 volumio volumio[4638]: info: Executing endpoint tc_getconfig Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 28 17:32:23 volumio vtcs[5858]: STARTING TidalConnect services, version: 1.5.2.56 Jan 28 17:32:23 volumio vtcs[5858]: STARTED TidalConnect services. Jan 28 17:32:23 volumio volumio[4638]: info: Executing endpoint tc_connect Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jan 28 17:32:23 volumio volumio[4638]: info: Connecting to TidalConnect Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::servicePushState Jan 28 17:32:23 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:32:23 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:32:23 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:23 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:32:23 volumio volumio[4638]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Jan 28 17:32:23 volumio volumio[4638]: verbose: CURRENT POSITION 0 Jan 28 17:32:23 volumio volumio[4638]: info: CoreStateMachine::syncState stateService stop Jan 28 17:32:23 volumio volumio[4638]: info: CoreStateMachine::syncState currentStatus stop Jan 28 17:32:23 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:32:23 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:32:23 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:23 volumio volumio[4638]: info: No code Jan 28 17:32:23 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:32:23 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:32:23 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::servicePushState Jan 28 17:32:23 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:32:23 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:32:23 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:23 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:32:23 volumio volumio[4638]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Jan 28 17:32:23 volumio volumio[4638]: verbose: CURRENT POSITION 0 Jan 28 17:32:23 volumio volumio[4638]: info: CoreStateMachine::syncState stateService stop Jan 28 17:32:23 volumio volumio[4638]: info: CoreStateMachine::syncState currentStatus stop Jan 28 17:32:23 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:32:23 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:32:23 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:23 volumio volumio[4638]: info: No code Jan 28 17:32:23 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:32:23 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:32:23 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:32:23 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:23 volumio volumio[4638]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.rDRBmnRicNe9IFSqzqbHi9PA03s2.00d479372362e622324f723a6f9709e0.state.status' Jan 28 17:32:23 volumio volumio[4638]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.rDRBmnRicNe9IFSqzqbHi9PA03s2.00d479372362e622324f723a6f9709e0.state.status' Jan 28 17:32:23 volumio volumio[4638]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.rDRBmnRicNe9IFSqzqbHi9PA03s2.00d479372362e622324f723a6f9709e0.state.status' Jan 28 17:32:23 volumio volumio[4638]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.rDRBmnRicNe9IFSqzqbHi9PA03s2.00d479372362e622324f723a6f9709e0.state.status' Jan 28 17:32:25 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:25 volumio volumio[4638]: info: TidalConnect service started! Jan 28 17:32:29 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:33 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:36 volumio volumio[4638]: verbose: New Socket.io Connection to rdrbmnricne9ifsqzqbhi9pa03s2-00d479372362e622324f723a6f9709e0.eu5.myvolumio.org from 127.0.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jan 28 17:32:36 volumio sudo[5916]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 17:32:36 volumio sudo[5916]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:36 volumio sudo[5916]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:36 volumio sudo[5918]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 17:32:36 volumio sudo[5918]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:36 volumio sudo[5918]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: verbose: New Socket.io Connection to 192.168.2.102 from 192.168.2.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jan 28 17:32:36 volumio volumio[4638]: info: Received Get System Info Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 17:32:36 volumio volumio[4638]: info: Discovery: Getting this device information Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetVisibleSources Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 28 17:32:36 volumio volumio[4638]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 28 17:32:36 volumio volumio[4638]: info: Received Get System Info Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 17:32:36 volumio volumio[4638]: info: Discovery: Getting this device information Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: Listing playlists Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: Received Get System Info Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 17:32:36 volumio volumio[4638]: info: Discovery: Getting this device information Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetVisibleSources Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 28 17:32:36 volumio volumio[4638]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 28 17:32:36 volumio volumio[4638]: info: Received Get System Info Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 17:32:36 volumio volumio[4638]: info: Discovery: Getting this device information Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: Listing playlists Jan 28 17:32:36 volumio volumio[4638]: info: Received Get System Info Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 17:32:36 volumio volumio[4638]: info: Discovery: Getting this device information Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 28 17:32:36 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 28 17:32:37 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:37 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:39 volumio volumio[4638]: info: Executing endpoint metavolumio Jan 28 17:32:39 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 17:32:41 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 17:32:42 volumio volumio[4638]: info: Retrieving Cloud Streaming UI Jan 28 17:32:42 volumio volumio[4638]: info: Getting Tidal Cloud Configuration Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 17:32:42 volumio volumio[4638]: info: Getting Qobuz Cloud Configuration Jan 28 17:32:42 volumio volumio[4638]: info: Asking plugin for UI Config Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 17:32:42 volumio volumio[4638]: info: Getting Spotify Cloud Configuration Jan 28 17:32:42 volumio volumio[4638]: info: Asking plugin for UI Config Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 17:32:42 volumio volumio[4638]: info: Saving Spotify Acccount Jan 28 17:32:42 volumio volumio[4638]: info: Got it Jan 28 17:32:42 volumio volumio[4638]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 28 17:32:42 volumio volumio[4638]: info: Got Tidal Cloud Configuration Jan 28 17:32:42 volumio volumio[4638]: info: Got it Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::volumioGetBrowseSources Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::volumioGetBrowseSources Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::volumioGetBrowseSources Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:42 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 28 17:32:45 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:46 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 28 17:32:46 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:46 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 28 17:32:49 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:50 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:53 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:54 volumio volumio[4638]: info: Disabling MyMusic plugin smart_inputs Jan 28 17:32:54 volumio volumio[4638]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service smart_inputs Jan 28 17:32:54 volumio volumio[4638]: info: Removeing all smart Inputs Jan 28 17:32:54 volumio volumio[4638]: info: Disabling plugin smart_inputs Jan 28 17:32:54 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:56 volumio volumio[4638]: info: Disabling MyMusic plugin qobuzconnect Jan 28 17:32:56 volumio volumio[4638]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service qobuzconnect Jan 28 17:32:56 volumio volumio[4638]: info: QobuzConnect: setDeactiveState invoked Jan 28 17:32:56 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:56 volumio qobuz-connect[5837]: 20260128 17:32:56.089 [5837.5837] INFO MediaEngine: [0x563a54267b00]: Stopping playback, keeping tracks Jan 28 17:32:56 volumio sudo[5974]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop qobuz-connect Jan 28 17:32:56 volumio sudo[5974]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:32:56 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jan 28 17:32:56 volumio qobuz-connect[5837]: 20260128 17:32:56.160 [5837.5837] INFO SampleApp: Stopping Local configuration server Jan 28 17:32:56 volumio qobuz-connect[5837]: 20260128 17:32:56.336 [5837.5837] INFO SampleApp: shat down connection on UNIX socket Jan 28 17:32:56 volumio volumio[4638]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Jan 28 17:32:56 volumio volumio[4638]: info: QobuzConnect: setDeactiveState invoked Jan 28 17:32:56 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:32:56 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Jan 28 17:32:56 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jan 28 17:32:56 volumio sudo[5974]: pam_unix(sudo:session): session closed for user root Jan 28 17:32:56 volumio volumio[4638]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket disconnected and tore down Jan 28 17:32:56 volumio volumio[4638]: info: Disabling plugin qobuzconnect Jan 28 17:32:57 volumio volumio[4638]: info: Disabling MyMusic plugin cd_controller Jan 28 17:32:57 volumio volumio[4638]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service cd_controller Jan 28 17:32:57 volumio volumio[4638]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Jan 28 17:32:57 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 17:32:57 volumio volumio[4638]: info: Stopping UDEV Watcher for CD Jan 28 17:32:57 volumio volumio[4638]: info: Disabling plugin cd_controller Jan 28 17:32:57 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:32:58 volumio volumio[4638]: info: Disabling MyMusic plugin metavolumio Jan 28 17:32:58 volumio volumio[4638]: info: [MyVolumio PluginManager] Disabling and stopping plugin miscellanea metavolumio Jan 28 17:32:58 volumio volumio[4638]: info: Removing METAVOLUMIO REST API Endpoints Jan 28 17:32:58 volumio volumio[4638]: info: Removing metavolumio REST Endpoint Jan 28 17:32:58 volumio volumio[4638]: info: Removing getSimilarArtists REST Endpoint Jan 28 17:32:58 volumio volumio[4638]: info: Removing getSimilarAlbums REST Endpoint Jan 28 17:32:58 volumio volumio[4638]: info: Removing getSimilarTracks REST Endpoint Jan 28 17:32:58 volumio volumio[4638]: info: Disabling plugin metavolumio Jan 28 17:32:58 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:33:01 volumio volumio[4638]: info: Disabling MyMusic plugin multiroom Jan 28 17:33:01 volumio volumio[4638]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface multiroom Jan 28 17:33:01 volumio volumio[4638]: info: Disabling plugin multiroom Jan 28 17:33:01 volumio volumio[4638]: info: Preparing to generate the ALSA configuration file Jan 28 17:33:01 volumio volumio[4638]: info: Asound.conf file written Jan 28 17:33:01 volumio sudo[5983]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 28 17:33:01 volumio sudo[5983]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:33:01 volumio sudo[5983]: pam_unix(sudo:session): session closed for user root Jan 28 17:33:01 volumio volumio[4638]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 28 17:33:01 volumio volumio[4638]: No state is present for card Audio Jan 28 17:33:01 volumio volumio[4638]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 28 17:33:01 volumio volumio[4638]: Found hardware: "HdmiLpeAudio" "" "" "" "" Jan 28 17:33:01 volumio volumio[4638]: Hardware is initialized using a generic method Jan 28 17:33:01 volumio volumio[4638]: No state is present for card Audio Jan 28 17:33:01 volumio volumio[4638]: No state is present for card D2MINI Jan 28 17:33:01 volumio volumio[4638]: Found hardware: "USB-Audio" "USB Mixer" "USB262a:9023" "" "" Jan 28 17:33:01 volumio volumio[4638]: Hardware is initialized using a generic method Jan 28 17:33:01 volumio volumio[4638]: No state is present for card D2MINI Jan 28 17:33:01 volumio volumio[4638]: info: Output device has changed, restarting MPD Jan 28 17:33:01 volumio volumio[4638]: info: Output device has changed, restarting Shairport Sync Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:33:01 volumio sudo[5989]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 28 17:33:01 volumio sudo[5989]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:33:01 volumio sudo[5991]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 28 17:33:01 volumio sudo[5991]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:33:01 volumio sudo[5989]: pam_unix(sudo:session): session closed for user root Jan 28 17:33:01 volumio volumio[4638]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 28 17:33:01 volumio volumio[4638]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:33:01 volumio volumio[4638]: info: QobuzConnect: setDeactiveState invoked Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:33:01 volumio vtcs[5858]: [2026-01-28 17:33:01.876] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jan 28 17:33:01 volumio vtcs[5858]: [2026-01-28 17:33:01.876] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jan 28 17:33:01 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 28 17:33:01 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 28 17:33:01 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 28 17:33:01 volumio systemd[1]: mpd.service: Consumed 1.181s CPU time. Jan 28 17:33:01 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 28 17:33:01 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 28 17:33:01 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 28 17:33:01 volumio sudo[6001]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 28 17:33:01 volumio sudo[6001]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:33:01 volumio sudo[6004]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 28 17:33:01 volumio sudo[6004]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:33:01 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:33:01 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 28 17:33:01 volumio volumio[4638]: info: MPD Permissions set Jan 28 17:33:01 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jan 28 17:33:01 volumio systemd[1]: vtcs.service: Killing process 5865 (vtcs) with signal SIGKILL. Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:33:01 volumio systemd[1]: vtcs.service: Deactivated successfully. Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:33:01 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jan 28 17:33:01 volumio ntpd[1048]: CLOCK: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:33:01 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:33:01 volumio sudo[6014]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 28 17:33:01 volumio sudo[6001]: pam_unix(sudo:session): session closed for user root Jan 28 17:33:01 volumio sudo[6014]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:33:02 volumio sudo[6004]: pam_unix(sudo:session): session closed for user root Jan 28 17:33:02 volumio sudo[6014]: pam_unix(sudo:session): session closed for user root Jan 28 17:33:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 28 17:33:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 28 17:33:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 28 17:33:02 volumio sudo[6023]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 28 17:33:02 volumio volumio[4638]: info: Starting Shairport Sync Jan 28 17:33:02 volumio sudo[6023]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:33:02 volumio sudo[6011]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 28 17:33:02 volumio sudo[6011]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 28 17:33:02 volumio sudo[6011]: pam_unix(sudo:session): session closed for user root Jan 28 17:33:02 volumio sudo[6029]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 28 17:33:02 volumio sudo[6029]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:33:02 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jan 28 17:33:02 volumio sudo[6023]: pam_unix(sudo:session): session closed for user root Jan 28 17:33:02 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 28 17:33:02 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 28 17:33:02 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 28 17:33:02 volumio systemd[1]: shairport-sync.service: Consumed 2.385s CPU time. Jan 28 17:33:02 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 28 17:33:02 volumio sudo[6029]: pam_unix(sudo:session): session closed for user root Jan 28 17:33:02 volumio volumio[4638]: info: Shairport-Sync Started Jan 28 17:33:02 volumio volumio[4638]: info: Executing endpoint qc_getconfig Jan 28 17:33:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 28 17:33:02 volumio qobuz-connect[6033]: 20260128 17:33:02.181 [6033.6033] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 28 17:33:02 volumio qobuz-connect[6033]: 20260128 17:33:02.187 [6033.6033] INFO VolumeManager: [0x56068a7c3300]: Setting new playback volume: 75 Jan 28 17:33:02 volumio qobuz-connect[6033]: 20260128 17:33:02.187 [6033.6033] INFO VolumeManager: [0x56068a7c3300]: Setting new mute state: 0 Jan 28 17:33:02 volumio qobuz-connect[6033]: qobuz-connect-daemon: /home/volumio/qobuz-connect-daemon/sample_console_app/volumio/pipe.c:199: pipe_connect_callback: Assertion `status == 0' failed. Jan 28 17:33:02 volumio systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=6/ABRT Jan 28 17:33:02 volumio systemd[1]: qobuz-connect.service: Failed with result 'signal'. Jan 28 17:33:02 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:33:03 volumio mpd[6032]: 2026-01-28T17:33:03 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 28 17:33:03 volumio systemd[1]: Started mpd.service - Music Player Daemon. Jan 28 17:33:03 volumio sudo[5991]: pam_unix(sudo:session): session closed for user root Jan 28 17:33:03 volumio volumio[4638]: error: updateQueue error: null Jan 28 17:33:04 volumio volumio[4638]: info: Disabling MyMusic plugin bluetooth Jan 28 17:33:04 volumio volumio[4638]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface bluetooth Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: [FUNC] onStop Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: [dbus-next] Disabling Bluetooth Audio Output Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: Bluetooth audio output stopped Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: [FUNC] stopBTStack Jan 28 17:33:04 volumio sudo[6057]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service Jan 28 17:33:04 volumio sudo[6057]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:33:04 volumio sudo[6057]: pam_unix(sudo:session): session closed for user root Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: volumiobt.service stopped successfully Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: volumiobt.service stopped Jan 28 17:33:04 volumio volumio[4638]: verbose: UNSET VOLATILE: Service: undefined Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: [FUNC] detachBluetooth Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: [dbus-next] Disabling Bluetooth Audio Output Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: Bluetooth audio output disabled. Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::resetVolumioState Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::getcurrentVolume Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioRetrievevolume Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::resetVolumioState Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::getcurrentVolume Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioRetrievevolume Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: Volumio state reset after Bluetooth stop Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioStop Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::stop Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioStop Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::stop Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 17:33:04 volumio volumio[4638]: ------------------------------------ BT MESSAGE: Failed to power off adapter: Jan 28 17:33:04 volumio volumio[4638]: info: Disabling plugin bluetooth Jan 28 17:33:04 volumio volumio[4638]: info: VolumeController:: Volume=39 Mute =false Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:33:04 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:33:04 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:33:04 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:33:04 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::updateTrackBlock Jan 28 17:33:04 volumio volumio[4638]: info: CorePlayQueue::getTrackBlock Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioRetrievevolume Jan 28 17:33:04 volumio volumio[4638]: info: VolumeController:: Volume=39 Mute =false Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:33:04 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:33:04 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:33:04 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:33:04 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::updateTrackBlock Jan 28 17:33:04 volumio volumio[4638]: info: CorePlayQueue::getTrackBlock Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioRetrievevolume Jan 28 17:33:04 volumio volumio[4638]: info: VolumeController:: Volume=39 Mute =false Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:33:04 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:33:04 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:33:04 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:33:04 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:04 volumio volumio[4638]: info: VolumeController:: Volume=39 Mute =false Jan 28 17:33:04 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:33:04 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:33:04 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:33:04 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:33:04 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:33:04 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: TidalConnect service stoped! Jan 28 17:33:05 volumio volumio[4638]: info: TidalConnect service stoped! Jan 28 17:33:05 volumio volumio[4638]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 28 17:33:05 volumio volumio[4638]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 28 17:33:05 volumio sudo[6079]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 28 17:33:05 volumio sudo[6079]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:33:05 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jan 28 17:33:05 volumio sudo[6079]: pam_unix(sudo:session): session closed for user root Jan 28 17:33:05 volumio volumio[4638]: info: Executing endpoint tc_getconfig Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 28 17:33:05 volumio vtcs[6082]: STARTING TidalConnect services, version: 1.5.2.56 Jan 28 17:33:05 volumio vtcs[6082]: STARTED TidalConnect services. Jan 28 17:33:05 volumio volumio[4638]: info: Executing endpoint tc_connect Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jan 28 17:33:05 volumio volumio[4638]: info: Connecting to TidalConnect Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::servicePushState Jan 28 17:33:05 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:33:05 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:33:05 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Jan 28 17:33:05 volumio volumio[4638]: verbose: CURRENT POSITION 0 Jan 28 17:33:05 volumio volumio[4638]: info: CoreStateMachine::syncState stateService stop Jan 28 17:33:05 volumio volumio[4638]: info: CoreStateMachine::syncState currentStatus stop Jan 28 17:33:05 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:33:05 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:33:05 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: No code Jan 28 17:33:05 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:33:05 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:33:05 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::servicePushState Jan 28 17:33:05 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:33:05 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:33:05 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Jan 28 17:33:05 volumio volumio[4638]: verbose: CURRENT POSITION 0 Jan 28 17:33:05 volumio volumio[4638]: info: CoreStateMachine::syncState stateService stop Jan 28 17:33:05 volumio volumio[4638]: info: CoreStateMachine::syncState currentStatus stop Jan 28 17:33:05 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:33:05 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:33:05 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: No code Jan 28 17:33:05 volumio volumio[4638]: info: CoreStateMachine::pushState Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::volumioPushState Jan 28 17:33:05 volumio volumio[4638]: info: MRS: Pushing multiroomSync output update for this device Jan 28 17:33:05 volumio volumio[4638]: info: MRS: Pushing multiroomSync output Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::volumioGetState Jan 28 17:33:05 volumio volumio[4638]: info: CorePlayQueue::getTrack 0 Jan 28 17:33:05 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:33:06 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:33:06 volumio volumio[4638]: info: Disabling MyMusic plugin upnp_browser Jan 28 17:33:06 volumio volumio[4638]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMedia Servers Jan 28 17:33:06 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 17:33:06 volumio volumio[4638]: info: Disabling plugin upnp_browser Jan 28 17:33:06 volumio volumio[4638]: info: Done. Jan 28 17:33:07 volumio systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 1. Jan 28 17:33:07 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jan 28 17:33:07 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jan 28 17:33:07 volumio volumio[4638]: info: Executing endpoint qc_getconfig Jan 28 17:33:07 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 28 17:33:07 volumio qobuz-connect[6114]: 20260128 17:33:07.519 [6114.6114] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 28 17:33:07 volumio qobuz-connect[6114]: 20260128 17:33:07.523 [6114.6114] INFO VolumeManager: [0x560398f6c300]: Setting new playback volume: 75 Jan 28 17:33:07 volumio qobuz-connect[6114]: 20260128 17:33:07.523 [6114.6114] INFO VolumeManager: [0x560398f6c300]: Setting new mute state: 0 Jan 28 17:33:07 volumio qobuz-connect[6114]: qobuz-connect-daemon: /home/volumio/qobuz-connect-daemon/sample_console_app/volumio/pipe.c:199: pipe_connect_callback: Assertion `status == 0' failed. Jan 28 17:33:07 volumio systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=6/ABRT Jan 28 17:33:07 volumio systemd[1]: qobuz-connect.service: Failed with result 'signal'. Jan 28 17:33:08 volumio volumio[4638]: info: TidalConnect service started! Jan 28 17:33:08 volumio volumio[4638]: info: Disabling MyMusic plugin airplay_emulation Jan 28 17:33:08 volumio volumio[4638]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Jan 28 17:33:08 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 17:33:08 volumio volumio[4638]: info: Disabling plugin airplay_emulation Jan 28 17:33:08 volumio volumio[4638]: info: Done. Jan 28 17:33:08 volumio sudo[6120]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Jan 28 17:33:08 volumio sudo[6120]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:33:08 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 28 17:33:08 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 28 17:33:08 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 28 17:33:08 volumio systemd[1]: shairport-sync.service: Consumed 1.659s CPU time. Jan 28 17:33:08 volumio sudo[6120]: pam_unix(sudo:session): session closed for user root Jan 28 17:33:08 volumio volumio[4638]: info: Shairport-Sync Stopped Jan 28 17:33:09 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:33:10 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:33:11 volumio volumio[4638]: info: Disabling MyMusic plugin upnp Jan 28 17:33:11 volumio sudo[6126]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jan 28 17:33:11 volumio sudo[6126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 17:33:11 volumio systemd[1]: Stopping upmpdcli.service - UPnP Renderer front-end to MPD... Jan 28 17:33:12 volumio systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 2. Jan 28 17:33:12 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jan 28 17:33:12 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jan 28 17:33:12 volumio volumio[4638]: info: Executing endpoint qc_getconfig Jan 28 17:33:12 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 28 17:33:12 volumio qobuz-connect[6129]: 20260128 17:33:12.767 [6129.6129] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 28 17:33:12 volumio qobuz-connect[6129]: 20260128 17:33:12.771 [6129.6129] INFO VolumeManager: [0x5593bbb52300]: Setting new playback volume: 75 Jan 28 17:33:12 volumio qobuz-connect[6129]: 20260128 17:33:12.771 [6129.6129] INFO VolumeManager: [0x5593bbb52300]: Setting new mute state: 0 Jan 28 17:33:12 volumio qobuz-connect[6129]: qobuz-connect-daemon: /home/volumio/qobuz-connect-daemon/sample_console_app/volumio/pipe.c:199: pipe_connect_callback: Assertion `status == 0' failed. Jan 28 17:33:12 volumio systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=6/ABRT Jan 28 17:33:12 volumio systemd[1]: qobuz-connect.service: Failed with result 'signal'. Jan 28 17:33:13 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:33:14 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:33:17 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:33:17 volumio systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 3. Jan 28 17:33:17 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Jan 28 17:33:17 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Jan 28 17:33:17 volumio volumio[4638]: info: Executing endpoint qc_getconfig Jan 28 17:33:17 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 28 17:33:18 volumio qobuz-connect[6152]: 20260128 17:33:18.021 [6152.6152] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 28 17:33:18 volumio qobuz-connect[6152]: 20260128 17:33:18.025 [6152.6152] INFO VolumeManager: [0x5555b976f300]: Setting new playback volume: 75 Jan 28 17:33:18 volumio qobuz-connect[6152]: 20260128 17:33:18.026 [6152.6152] INFO VolumeManager: [0x5555b976f300]: Setting new mute state: 0 Jan 28 17:33:18 volumio qobuz-connect[6152]: qobuz-connect-daemon: /home/volumio/qobuz-connect-daemon/sample_console_app/volumio/pipe.c:199: pipe_connect_callback: Assertion `status == 0' failed. Jan 28 17:33:18 volumio systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=6/ABRT Jan 28 17:33:18 volumio systemd[1]: qobuz-connect.service: Failed with result 'signal'. Jan 28 17:33:18 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 17:33:20 volumio volumio[4638]: info: Enabling MyMusic plugin upnp Jan 28 17:33:20 volumio volumio[4638]: info: Enabling plugin upnp Jan 28 17:33:20 volumio volumio[4638]: info: Loading plugin "upnp"... Jan 28 17:33:20 volumio volumio[4638]: info: [1769618000882] Starting Upmpd Daemon Jan 28 17:33:20 volumio volumio[4638]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 28 17:33:20 volumio volumio[4638]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 17:33:20 volumio volumio[4638]: Error: listen EADDRINUSE: address already in use :::6599 Jan 28 17:33:20 volumio volumio[4638]: at Server.setupListenHandle [as _listen2] (node:net:1872:16) Jan 28 17:33:20 volumio volumio[4638]: at listenInCluster (node:net:1920:12) Jan 28 17:33:20 volumio volumio[4638]: at Server.listen (node:net:2008:7) Jan 28 17:33:20 volumio volumio[4638]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jan 28 17:33:20 volumio volumio[4638]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jan 28 17:33:20 volumio volumio[4638]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jan 28 17:33:20 volumio volumio[4638]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 28 17:33:20 volumio volumio[4638]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Jan 28 17:33:20 volumio volumio[4638]: code: 'EADDRINUSE', Jan 28 17:33:20 volumio volumio[4638]: errno: -98, Jan 28 17:33:20 volumio volumio[4638]: syscall: 'listen', Jan 28 17:33:20 volumio volumio[4638]: address: '::', Jan 28 17:33:20 volumio volumio[4638]: port: 6599 Jan 28 17:33:20 volumio volumio[4638]: } Jan 28 17:33:20 volumio volumio[4638]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 17:33:21 volumio sudo[6174]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-28 17:32' Jan 28 17:33:21 volumio sudo[6174]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:38:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="00e933ebe3692ad8aea9910d2289bf23"