Dec 30 16:43:03 volumio volumio[1206]: info: Dec 30 16:43:03 volumio volumio[1206]: ---------------------------- MPD announces system playlist update Dec 30 16:43:03 volumio volumio[1206]: info: Ignoring MPD Status Update Dec 30 16:43:03 volumio volumio[1206]: info: Dec 30 16:43:03 volumio volumio[1206]: ---------------------------- MPD announces state update: player Dec 30 16:43:03 volumio volumio[1206]: info: ControllerMpd::getState Dec 30 16:43:03 volumio volumio[1206]: verbose: ControllerMpd::sendMpdCommand status Dec 30 16:43:03 volumio volumio[1206]: info: ------------------------------ 4ms Dec 30 16:43:03 volumio volumio[1206]: info: sendMpdCommand status took 4 milliseconds Dec 30 16:43:03 volumio volumio[1206]: verbose: ControllerMpd::parseState Dec 30 16:43:03 volumio volumio[1206]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 16:43:03 volumio volumio[1206]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 30 16:43:03 volumio volumio[1206]: verbose: ControllerMpd::parseTrackInfo Dec 30 16:43:03 volumio volumio[1206]: info: ControllerMpd::pushState Dec 30 16:43:03 volumio volumio[1206]: info: CoreCommandRouter::servicePushState Dec 30 16:43:03 volumio volumio[1206]: info: CorePlayQueue::getTrack 37 Dec 30 16:43:03 volumio volumio[1206]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7604730,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Arctic Monkeys - Do I Wanna Know?","artist":"NPO Radio2","album":null,"uri":"https://icecast.omroep.nl/radio2-bb-mp3","trackType":""} Dec 30 16:43:03 volumio volumio[1206]: verbose: CURRENT POSITION 37 Dec 30 16:43:03 volumio volumio[1206]: info: CoreStateMachine::syncState stateService play Dec 30 16:43:03 volumio volumio[1206]: info: CoreStateMachine::syncState currentStatus play Dec 30 16:43:03 volumio volumio[1206]: info: Received an update from plugin. extracting info from payload Dec 30 16:43:03 volumio volumio[1206]: info: CoreStateMachine::pushState Dec 30 16:43:03 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 16:43:03 volumio volumio[1206]: info: CoreCommandRouter::volumioPushState Dec 30 16:43:03 volumio volumio[1206]: info: CoreStateMachine::pushState Dec 30 16:43:03 volumio volumio[1206]: info: CoreCommandRouter::volumioPushState Dec 30 16:43:03 volumio volumio[1206]: info: ------------------------------ 28ms Dec 30 16:43:05 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 30 16:43:05 volumio volumio[1206]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 30 16:43:05 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 30 16:43:05 volumio volumio[1206]: info: Received Get System Version Dec 30 16:43:05 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 16:43:05 volumio volumio[1206]: info: Received Get System Info Dec 30 16:43:05 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 16:43:05 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 16:43:05 volumio volumio[1206]: info: Discovery: Getting this device information Dec 30 16:43:05 volumio volumio[1206]: info: CoreCommandRouter::volumioGetState Dec 30 16:43:05 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 16:43:08 volumio volumio[1206]: info: CoreCommandRouter::volumioGetState Dec 30 16:43:18 volumio kernel: hwmon hwmon1: Voltage normalised Dec 30 16:43:18 volumio volumio[1206]: info: CoreCommandRouter::volumioGetState Dec 30 16:43:18 volumio volumio[1206]: info: Listing playlists Dec 30 16:43:18 volumio volumio[1206]: info: Listing playlists Dec 30 16:43:20 volumio kernel: hwmon hwmon1: Undervoltage detected! Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 30 16:43:22 volumio volumio[1206]: info: Getting Alsa Cards List without I2S DAC Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 30 16:43:22 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 30 16:43:28 volumio volumio[1206]: info: CoreCommandRouter::volumioGetState Dec 30 16:43:35 volumio volumio[1206]: info: CoreCommandRouter::volumioGetState Dec 30 16:43:37 volumio volumio[1206]: info: Executing endpoint metavolumio Dec 30 16:43:37 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 30 16:43:37 volumio volumio[1206]: info: Executing endpoint metavolumio Dec 30 16:43:37 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 30 16:43:38 volumio volumio[1206]: info: CoreCommandRouter::volumioGetState Dec 30 16:43:38 volumio volumio[1206]: info: Listing playlists Dec 30 16:43:38 volumio volumio[1206]: info: Listing playlists Dec 30 16:43:38 volumio volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 16:43:38 volumio volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 16:43:38 volumio volumio[1206]: info: Retrieving Cloud Streaming UI Dec 30 16:43:38 volumio volumio[1206]: info: Getting Tidal Cloud Configuration Dec 30 16:43:38 volumio volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 16:43:38 volumio volumio[1206]: info: Getting Qobuz Cloud Configuration Dec 30 16:43:38 volumio volumio[1206]: info: Asking plugin for UI Config Dec 30 16:43:38 volumio volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 16:43:38 volumio volumio[1206]: info: Getting Spotify Cloud Configuration Dec 30 16:43:38 volumio volumio[1206]: info: Asking plugin for UI Config Dec 30 16:43:38 volumio volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 16:43:38 volumio volumio[1206]: info: Saving Spotify Acccount Dec 30 16:43:38 volumio volumio[1206]: info: Got it Dec 30 16:43:38 volumio volumio[1206]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 30 16:43:38 volumio volumio[1206]: info: Got Tidal Cloud Configuration Dec 30 16:43:38 volumio volumio[1206]: info: Got it Dec 30 16:43:38 volumio volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::volumioGetBrowseSources Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::volumioGetBrowseSources Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::volumioGetBrowseSources Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 30 16:43:39 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 30 16:43:43 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 30 16:43:47 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 30 16:43:48 volumio volumio[1206]: info: CoreCommandRouter::volumioGetState Dec 30 16:43:51 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 30 16:43:54 volumio volumio[1206]: info: Enabling MyMusic plugin multiroom Dec 30 16:43:54 volumio volumio[1206]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface multiroom Dec 30 16:43:54 volumio volumio[1206]: info: Enabling plugin multiroom Dec 30 16:43:54 volumio volumio[1206]: info: Preparing to generate the ALSA configuration file Dec 30 16:43:54 volumio volumio[1206]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 30 16:43:54 volumio volumio[1206]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 30 16:43:54 volumio volumio[1206]: info: Reading ALSA contributions from plugins. Dec 30 16:43:54 volumio volumio[1206]: info: Asound.conf file written Dec 30 16:43:54 volumio sudo[10333]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 30 16:43:54 volumio sudo[10333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:54 volumio kernel: EXT4-fs error (device mmcblk0p3) in ext4_mb_clear_bb:6545: Corrupt filesystem Dec 30 16:43:54 volumio sudo[10333]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:54 volumio volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 30 16:43:54 volumio volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 30 16:43:54 volumio volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Dec 30 16:43:54 volumio volumio[1206]: info: Output device has changed, restarting MPD Dec 30 16:43:54 volumio volumio[1206]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 30 16:43:54 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:54 volumio sudo[10339]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 30 16:43:54 volumio sudo[10339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:54 volumio sudo[10339]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:54 volumio vtcs[1787]: [2025-12-30 16:43:54.761] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 30 16:43:54 volumio sudo[10341]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 30 16:43:54 volumio sudo[10341]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:54 volumio vtcs[1787]: [2025-12-30 16:43:54.772] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=8 errorno=104 error=Connection reset by peer Dec 30 16:43:54 volumio vtcs[1787]: [2025-12-30 16:43:54.772] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 30 16:43:54 volumio volumio[1206]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Dec 30 16:43:54 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Dec 30 16:43:54 volumio volumio[1206]: info: MRS: Pushing multiroomSync output for this device Dec 30 16:43:54 volumio volumio[1206]: info: MRS: Pushing multiroomSync output Dec 30 16:43:54 volumio volumio[1206]: info: Adding audio output: Dec 30 16:43:54 volumio volumio[1206]: info: Adding audio output: Dec 30 16:43:54 volumio sudo[10347]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 30 16:43:54 volumio sudo[10347]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:54 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 30 16:43:54 volumio volumio[1206]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 30 16:43:54 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:54 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 30 16:43:54 volumio systemd[1]: vtcs.service: Killing process 1790 (vtcs) with signal SIGKILL. Dec 30 16:43:54 volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 30 16:43:54 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 30 16:43:54 volumio systemd[1]: vtcs.service: Consumed 21.094s CPU time. Dec 30 16:43:54 volumio sudo[10347]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:54 volumio volumio[1206]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Dec 30 16:43:54 volumio volumio[1206]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Dec 30 16:43:54 volumio volumio[1206]: info: MPD Permissions set Dec 30 16:43:54 volumio sudo[10353]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 30 16:43:55 volumio sudo[10353]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:55 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 30 16:43:55 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 30 16:43:55 volumio systemd[1]: mpd.service: Consumed 19min 43.117s CPU time. Dec 30 16:43:55 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 30 16:43:55 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 30 16:43:55 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 30 16:43:55 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:55 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:55 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:55 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:55 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:55 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:55 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:55 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:55 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 16:43:55 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:55 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 30 16:43:55 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 30 16:43:55 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 30 16:43:55 volumio volumio[1206]: info: Preparing to generate the ALSA configuration file Dec 30 16:43:55 volumio sudo[10353]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:55 volumio volumio[1206]: info: Done. Dec 30 16:43:55 volumio volumio[1206]: info: MRS: Found cast device: BRAVIA-4K-VH22-76bd802ee135ac1434374faf0e9c5097 Dec 30 16:43:55 volumio volumio[1206]: info: Adding audio output: Dec 30 16:43:55 volumio volumio[1206]: info: MRS: Found cast device: Google-Nest-Hub-2a5efdb1161b607b1ddbd2af30d2fc17 Dec 30 16:43:55 volumio volumio[1206]: info: Adding audio output: Dec 30 16:43:55 volumio volumio[1206]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 30 16:43:55 volumio volumio[1206]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 30 16:43:55 volumio volumio[1206]: info: Reading ALSA contributions from plugins. Dec 30 16:43:55 volumio volumio[1206]: info: Asound.conf file written Dec 30 16:43:55 volumio sudo[10370]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 30 16:43:55 volumio sudo[10370]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:55 volumio sudo[10370]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:55 volumio volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 30 16:43:55 volumio volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 30 16:43:55 volumio volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Dec 30 16:43:55 volumio volumio[1206]: info: Output device has changed, restarting MPD Dec 30 16:43:55 volumio volumio[1206]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 30 16:43:55 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:55 volumio sudo[10365]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 30 16:43:55 volumio sudo[10365]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 30 16:43:55 volumio sudo[10378]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 30 16:43:55 volumio sudo[10378]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:55 volumio sudo[10378]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:55 volumio sudo[10365]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:55 volumio sudo[10380]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 30 16:43:55 volumio volumio[1206]: info: Preparing to generate the ALSA configuration file Dec 30 16:43:55 volumio sudo[10380]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:55 volumio sudo[10387]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 30 16:43:55 volumio sudo[10387]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:55 volumio volumio[1206]: info: MRS: Found cast device: KPN-DIW7022-fa19a3ce56eea32f99b71edfc8306d8e Dec 30 16:43:55 volumio volumio[1206]: info: Adding audio output: Dec 30 16:43:55 volumio volumio[1206]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 30 16:43:55 volumio volumio[1206]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 30 16:43:55 volumio volumio[1206]: info: Reading ALSA contributions from plugins. Dec 30 16:43:55 volumio sudo[10391]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 30 16:43:55 volumio sudo[10391]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:55 volumio volumio[1206]: info: MPD Permissions set Dec 30 16:43:55 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 30 16:43:55 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 30 16:43:55 volumio sudo[10387]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:55 volumio sudo[10391]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:56 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 30 16:43:56 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 30 16:43:56 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 30 16:43:56 volumio volumio[1206]: info: Adding audio output: Dec 30 16:43:56 volumio volumio[1206]: info: Adding audio output: Dec 30 16:43:56 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: Asound.conf file unchanged, so no further update is needed Dec 30 16:43:56 volumio volumio[1206]: info: Output device has changed, restarting MPD Dec 30 16:43:56 volumio volumio[1206]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio sudo[10406]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 30 16:43:56 volumio sudo[10406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:56 volumio sudo[10406]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:56 volumio volumio[1206]: info: Preparing to generate the ALSA configuration file Dec 30 16:43:56 volumio sudo[10408]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 30 16:43:56 volumio sudo[10408]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:56 volumio sudo[10413]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 30 16:43:56 volumio sudo[10413]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:56 volumio volumio[1206]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 30 16:43:56 volumio volumio[1206]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 30 16:43:56 volumio volumio[1206]: info: Reading ALSA contributions from plugins. Dec 30 16:43:56 volumio volumio[1206]: info: MPD Permissions set Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio sudo[10417]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 30 16:43:56 volumio sudo[10417]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: Asound.conf file written Dec 30 16:43:56 volumio sudo[10426]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 30 16:43:56 volumio sudo[10426]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:56 volumio sudo[10426]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:56 volumio sudo[10399]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 30 16:43:56 volumio sudo[10399]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 30 16:43:56 volumio sudo[10399]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:56 volumio volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 30 16:43:56 volumio volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 30 16:43:56 volumio volumio[1206]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Dec 30 16:43:56 volumio volumio[1206]: info: Output device has changed, restarting MPD Dec 30 16:43:56 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 30 16:43:56 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 30 16:43:56 volumio volumio[1206]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio sudo[10432]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 30 16:43:56 volumio sudo[10432]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:56 volumio sudo[10432]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:56 volumio sudo[10434]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 30 16:43:56 volumio sudo[10434]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:56 volumio sudo[10413]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:56 volumio sudo[10439]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 30 16:43:56 volumio volumio[1206]: info: MPD Permissions set Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:56 volumio sudo[10417]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:56 volumio sudo[10439]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:56 volumio sudo[10442]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 30 16:43:56 volumio sudo[10442]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 16:43:56 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 16:43:57 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 30 16:43:57 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 30 16:43:57 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 30 16:43:57 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 30 16:43:57 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 30 16:43:57 volumio sudo[10439]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:57 volumio sudo[10442]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:57 volumio sudo[10453]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 30 16:43:57 volumio sudo[10453]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 30 16:43:57 volumio sudo[10453]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:57 volumio volumio[1206]: info: TidalConnect service stoped! Dec 30 16:43:58 volumio volumio[1206]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 16:43:58 volumio volumio[1206]: info: TidalConnect service stoped! Dec 30 16:43:58 volumio volumio[1206]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 30 16:43:58 volumio volumio[1206]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 30 16:43:58 volumio volumio[1206]: info: CoreCommandRouter::volumioGetState Dec 30 16:43:58 volumio volumio[1206]: info: Listing playlists Dec 30 16:43:58 volumio volumio[1206]: info: Listing playlists Dec 30 16:43:58 volumio sudo[10473]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 30 16:43:58 volumio sudo[10473]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 16:43:58 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 30 16:43:58 volumio sudo[10473]: pam_unix(sudo:session): session closed for user root Dec 30 16:43:58 volumio volumio[1206]: info: TidalConnect service stoped! Dec 30 16:43:58 volumio volumio[1206]: info: Executing endpoint tc_getconfig Dec 30 16:43:58 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 30 16:43:58 volumio vtcs[10476]: STARTING TidalConnect services, version: 1.5.2.56 Dec 30 16:43:58 volumio volumio[1206]: info: TidalConnect service stoped! Dec 30 16:43:59 volumio vtcs[10476]: STARTED TidalConnect services. Dec 30 16:43:59 volumio volumio[1206]: info: Executing endpoint tc_connect Dec 30 16:43:59 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 30 16:43:59 volumio volumio[1206]: info: Connecting to TidalConnect Dec 30 16:43:59 volumio volumio[1206]: info: CoreCommandRouter::servicePushState Dec 30 16:43:59 volumio volumio[1206]: info: CoreStateMachine::pushState Dec 30 16:43:59 volumio volumio[1206]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 16:43:59 volumio volumio[1206]: info: CoreCommandRouter::volumioPushState Dec 30 16:43:59 volumio volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:43:59 volumio volumio[1206]: info: MRS: Pushing multiroomSync output Dec 30 16:43:59 volumio volumio[1206]: info: CorePlayQueue::getTrack 37 Dec 30 16:43:59 volumio volumio[1206]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Dec 30 16:43:59 volumio volumio[1206]: info: CoreCommandRouter::servicePushState Dec 30 16:43:59 volumio volumio[1206]: info: CoreStateMachine::pushState Dec 30 16:43:59 volumio volumio[1206]: info: CoreCommandRouter::volumioPushState Dec 30 16:43:59 volumio volumio[1206]: info: MRS: Pushing multiroomSync output update for this device Dec 30 16:43:59 volumio volumio[1206]: info: MRS: Pushing multiroomSync output Dec 30 16:43:59 volumio volumio[1206]: info: CorePlayQueue::getTrack 37 Dec 30 16:43:59 volumio volumio[1206]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Dec 30 16:43:59 volumio volumio[1206]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 30 16:43:59 volumio volumio[1206]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 30 16:43:59 volumio volumio[1206]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 16:43:59 volumio volumio[1206]: Error: ENOENT: no such file or directory, unlink '/tmp/04qHyoIJN7LqqdFY7INIRWwvA6y2D8COhEk2Mz5wsqAcxq5yRgFrYsaSOml8aKb3e0gocEcm6pkdtVkXuhGfNltEBWmaREjZv23u' Dec 30 16:43:59 volumio volumio[1206]: at Object.unlinkSync (node:fs:1899:3) Dec 30 16:43:59 volumio volumio[1206]: at ControllerTidalconnect.deleteCertificate (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:11238) Dec 30 16:43:59 volumio volumio[1206]: at TidalConnectClient. (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:2774) Dec 30 16:43:59 volumio volumio[1206]: at TidalConnectClient.emit (node:events:514:28) Dec 30 16:43:59 volumio volumio[1206]: at TidalConnectClient.parseData (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:44661) Dec 30 16:43:59 volumio volumio[1206]: at /myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:41631 Dec 30 16:43:59 volumio volumio[1206]: at Array.forEach () Dec 30 16:43:59 volumio volumio[1206]: at Socket. (/myvolumio/plugins/music_service/tidalconnect/tidalconnect_real:1:41509) Dec 30 16:43:59 volumio volumio[1206]: at Socket.emit (node:events:514:28) Dec 30 16:43:59 volumio volumio[1206]: at addChunk (node:internal/streams/readable:343:12) Dec 30 16:43:59 volumio volumio[1206]: at readableAddChunk (node:internal/streams/readable:316:9) Dec 30 16:43:59 volumio volumio[1206]: at Readable.push (node:internal/streams/readable:253:10) Dec 30 16:43:59 volumio volumio[1206]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) { Dec 30 16:43:59 volumio volumio[1206]: errno: -2, Dec 30 16:43:59 volumio volumio[1206]: syscall: 'unlink', Dec 30 16:43:59 volumio volumio[1206]: code: 'ENOENT', Dec 30 16:43:59 volumio volumio[1206]: path: '/tmp/04qHyoIJN7LqqdFY7INIRWwvA6y2D8COhEk2Mz5wsqAcxq5yRgFrYsaSOml8aKb3e0gocEcm6pkdtVkXuhGfNltEBWmaREjZv23u' Dec 30 16:43:59 volumio volumio[1206]: } Dec 30 16:43:59 volumio volumio[1206]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 16:44:00 volumio sudo[10514]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-30 16:43' Dec 30 16:44:00 volumio sudo[10514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"