Dec 18 10:03:37 volumio volumio[1313]: verbose: New Socket.io Connection to 192.168.1.177 from 192.168.1.130 UA: Mozilla/5.0 (Linux; Android 16; 24129PN74G Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Dec 18 10:03:37 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 18 10:03:37 volumio volumio[1313]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 18 10:03:37 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 18 10:03:37 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:37 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Dec 18 10:03:37 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 18 10:03:37 volumio volumio[1313]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Dec 18 10:03:37 volumio volumio[1313]: info: Received Get System Info
Dec 18 10:03:37 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 18 10:03:37 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 18 10:03:37 volumio volumio[1313]: info: Discovery: Getting this device information
Dec 18 10:03:37 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:37 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 18 10:03:37 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:37 volumio volumio[1313]: info: Listing playlists
Dec 18 10:03:38 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Dec 18 10:03:41 volumio kernel: usb 1-1: new high-speed USB device number 4 using xhci-hcd
Dec 18 10:03:41 volumio kernel: usb 1-1: New USB device found, idVendor=2972, idProduct=0144, bcdDevice= 0.02
Dec 18 10:03:41 volumio kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Dec 18 10:03:41 volumio kernel: usb 1-1: Product: FiiO Warmer
Dec 18 10:03:41 volumio kernel: usb 1-1: Manufacturer: FIIO
Dec 18 10:03:41 volumio kernel: hid-generic 0003:2972:0144.0003: No inputs registered, leaving
Dec 18 10:03:41 volumio kernel: hid-generic 0003:2972:0144.0003: hiddev96,hidraw0: USB HID v1.00 Device [FIIO FiiO Warmer] on usb-xhci-hcd.0-1/input0
Dec 18 10:03:41 volumio kernel: usbcore: registered new interface driver snd-usb-audio
Dec 18 10:03:41 volumio volumio[1313]: info:
Dec 18 10:03:41 volumio volumio[1313]: ---------------------------- USB Audio Device Attached
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::Close All Modals sent
Dec 18 10:03:41 volumio volumio[1313]: info: Preparing to save Alsa Options, stopping services first
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:41 volumio volumio[1313]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"FiiO Warmer","alsacard":"Warmer"},"i2s":false}
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 18 10:03:41 volumio volumio[1313]: info: Setting mixer PCM for card FiiO Warmer
Dec 18 10:03:41 volumio volumio[1313]: info: QobuzConnect: setDeactiveState invoked
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:41 volumio vtcs[2126]: [2025-12-18 10:03:41.814] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected
Dec 18 10:03:41 volumio vtcs[2126]: [2025-12-18 10:03:41.814] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE
Dec 18 10:03:41 volumio sudo[11353]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 18 10:03:41 volumio sudo[11353]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Dec 18 10:03:41 volumio volumio[1313]: info: Updating Volume Controller Parameters: Device: 5 Name: FiiO Warmer Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Dec 18 10:03:41 volumio volumio[1313]: info: Disabling external Volume Control
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 18 10:03:41 volumio volumio[1313]: info: Preparing to generate the ALSA configuration file
Dec 18 10:03:41 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service...
Dec 18 10:03:41 volumio systemd[1]: vtcs.service: Killing process 2135 (vtcs) with signal SIGKILL.
Dec 18 10:03:41 volumio systemd[1]: vtcs.service: Deactivated successfully.
Dec 18 10:03:41 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service.
Dec 18 10:03:41 volumio sudo[11353]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:41 volumio sudo[11360]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 18 10:03:41 volumio sudo[11360]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:41 volumio volumio[1313]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Dec 18 10:03:41 volumio volumio[1313]: info: Reading ALSA contributions from plugins.
Dec 18 10:03:41 volumio sudo[11368]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 18 10:03:41 volumio sudo[11368]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:41 volumio sudo[11360]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 18 10:03:41 volumio sudo[11368]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:41 volumio sudo[11375]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 18 10:03:41 volumio sudo[11375]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 18 10:03:41 volumio volumio[1313]: info: VolumeController:: Volume=41 Mute =false
Dec 18 10:03:41 volumio volumio[1313]: info: CoreStateMachine::pushState
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::volumioPushState
Dec 18 10:03:41 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service...
Dec 18 10:03:41 volumio volumio[1313]: info: MRS: Pushing multiroomSync output update for this device
Dec 18 10:03:41 volumio volumio[1313]: info: MRS: Pushing multiroomSync output
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:41 volumio qobuz-connect[2105]: 20251218 10:03:41.923 [2105.2105] INFO SampleApp: Stopping Local configuration server
Dec 18 10:03:41 volumio volumio[1313]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Dec 18 10:03:41 volumio volumio[1313]: SPOTIFY: SPOTIFY VOLUME undefined
Dec 18 10:03:41 volumio volumio[1313]: SPOTIFY: VOLUMIO VOLUME 41
Dec 18 10:03:41 volumio volumio[1313]: info: Aligning Spotify Volume to Volumio Volume
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:41 volumio volumio[1313]: info: Setting Spotify Volume from Volumio: 41
Dec 18 10:03:41 volumio volumio[1313]: info: Asound.conf file unchanged, so no further update is needed
Dec 18 10:03:41 volumio volumio[1313]: info: Output device has changed, restarting MPD
Dec 18 10:03:41 volumio volumio[1313]: info: Output device has changed, restarting Shairport Sync
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 10:03:41 volumio sudo[11383]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 18 10:03:41 volumio sudo[11383]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:41 volumio sudo[11385]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 18 10:03:41 volumio sudo[11385]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:41 volumio sudo[11383]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:41 volumio volumio[1313]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 18 10:03:41 volumio volumio[1313]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:41 volumio volumio[1313]: info: QobuzConnect: setDeactiveState invoked
Dec 18 10:03:41 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:41 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Dec 18 10:03:41 volumio sudo[11395]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 18 10:03:41 volumio sudo[11395]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:41 volumio sudo[11397]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 18 10:03:41 volumio sudo[11397]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:42 volumio volumio[1313]: info: MPD Permissions set
Dec 18 10:03:42 volumio sudo[11397]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio sudo[11405]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 18 10:03:42 volumio sudo[11405]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio sudo[11395]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio sudo[11405]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio sudo[11414]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 18 10:03:42 volumio sudo[11414]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:42 volumio systemd[1]: mpd.service: Deactivated successfully.
Dec 18 10:03:42 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Dec 18 10:03:42 volumio systemd[1]: mpd.socket: Deactivated successfully.
Dec 18 10:03:42 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Dec 18 10:03:42 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: Starting Shairport Sync
Dec 18 10:03:42 volumio volumio[1313]: info: Preparing to generate the ALSA configuration file
Dec 18 10:03:42 volumio sudo[11418]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 18 10:03:42 volumio sudo[11418]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:42 volumio volumio[1313]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Dec 18 10:03:42 volumio volumio[1313]: info: Reading ALSA contributions from plugins.
Dec 18 10:03:42 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Dec 18 10:03:42 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Dec 18 10:03:42 volumio volumio[1313]: info: Asound.conf file written
Dec 18 10:03:42 volumio sudo[11423]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Dec 18 10:03:42 volumio sudo[11423]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:42 volumio sudo[11423]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Dec 18 10:03:42 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Dec 18 10:03:42 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 18 10:03:42 volumio systemd[1]: shairport-sync.service: Consumed 6.042s CPU time.
Dec 18 10:03:42 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 18 10:03:42 volumio sudo[11418]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio volumio[1313]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2
Dec 18 10:03:42 volumio volumio[1313]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2
Dec 18 10:03:42 volumio volumio[1313]: info: Output device has changed, restarting MPD
Dec 18 10:03:42 volumio volumio[1313]: info: Output device has changed, restarting Shairport Sync
Dec 18 10:03:42 volumio sudo[11433]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 18 10:03:42 volumio sudo[11433]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 10:03:42 volumio sudo[11433]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio sudo[11435]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 18 10:03:42 volumio sudo[11435]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:42 volumio volumio[1313]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 18 10:03:42 volumio volumio[1313]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: QobuzConnect: setDeactiveState invoked
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:42 volumio sudo[11420]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 18 10:03:42 volumio sudo[11420]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 18 10:03:42 volumio sudo[11420]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio systemd[1]: mpd.service: Deactivated successfully.
Dec 18 10:03:42 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Dec 18 10:03:42 volumio systemd[1]: mpd.socket: Deactivated successfully.
Dec 18 10:03:42 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Dec 18 10:03:42 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Dec 18 10:03:42 volumio sudo[11461]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 18 10:03:42 volumio sudo[11458]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 18 10:03:42 volumio sudo[11458]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:42 volumio sudo[11461]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:42 volumio volumio[1313]: info: MPD Permissions set
Dec 18 10:03:42 volumio volumio[1313]: info: Shairport-Sync Started
Dec 18 10:03:42 volumio sudo[11471]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 18 10:03:42 volumio sudo[11471]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:42 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Dec 18 10:03:42 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 10:03:42 volumio volumio[1313]: info: Starting Shairport Sync
Dec 18 10:03:42 volumio sudo[11471]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio sudo[11480]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 18 10:03:42 volumio sudo[11481]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 18 10:03:42 volumio sudo[11481]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:42 volumio sudo[11458]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio sudo[11480]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:42 volumio sudo[11473]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 18 10:03:42 volumio sudo[11473]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 18 10:03:42 volumio sudo[11473]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio sudo[11461]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Dec 18 10:03:42 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Dec 18 10:03:42 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 18 10:03:42 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Dec 18 10:03:42 volumio sudo[11480]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio volumio[1313]: info: Shairport-Sync Started
Dec 18 10:03:42 volumio volumio[1313]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Dec 18 10:03:42 volumio volumio[1313]: info: QobuzConnect: setDeactiveState invoked
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:42 volumio qobuz-connect[2105]: 20251218 10:03:42.558 [2105.2105] INFO SampleApp: shat down connection on UNIX socket
Dec 18 10:03:42 volumio systemd[1]: qobuz-connect.service: Deactivated successfully.
Dec 18 10:03:42 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service.
Dec 18 10:03:42 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service.
Dec 18 10:03:42 volumio sudo[11414]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio sudo[11375]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio sudo[11481]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:42 volumio volumio[1313]: info: Executing endpoint qc_getconfig
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Dec 18 10:03:42 volumio qobuz-connect[11503]: 20251218 10:03:42.618 [11503.11503] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Dec 18 10:03:42 volumio volumio[1313]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Dec 18 10:03:42 volumio volumio[1313]: info: QobuzConnect: QOBUZ Connect daemon connected
Dec 18 10:03:42 volumio qobuz-connect[11503]: 20251218 10:03:42.620 [11503.11503] INFO VolumeManager: [0x1554348]: Setting new playback volume: 75
Dec 18 10:03:42 volumio qobuz-connect[11503]: 20251218 10:03:42.620 [11503.11503] INFO VolumeManager: [0x1554348]: Setting new mute state: 0
Dec 18 10:03:42 volumio qobuz-connect[11503]: 20251218 10:03:42.620 [11503.11503] INFO QobuzConnect: [0x1554d18]: Client initialized!
Dec 18 10:03:42 volumio qobuz-connect[11503]: 20251218 10:03:42.620 [11503.11503] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp
Dec 18 10:03:42 volumio qobuz-connect[11503]: 20251218 10:03:42.632 [11503.11503] INFO LocalConfigManager: [0x1553c28]: Starting Local Configuration server
Dec 18 10:03:42 volumio qobuz-connect[11503]: 20251218 10:03:42.632 [11503.11503] INFO SampleApp: Starting Local configuration server
Dec 18 10:03:42 volumio qobuz-connect[11503]: 20251218 10:03:42.632 [11503.11503] INFO SampleApp: Connected to UNIX socket client 0x153e818
Dec 18 10:03:42 volumio qobuz-connect[11503]: 20251218 10:03:42.769 [11503.11503] INFO SampleApp: Playback volume changed: 75
Dec 18 10:03:42 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:42 volumio mpd[11486]: 2025-12-18T10:03:42 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 18 10:03:43 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Dec 18 10:03:43 volumio sudo[11435]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:43 volumio sudo[11385]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:43 volumio volumio[1313]: error: updateQueue error: null
Dec 18 10:03:43 volumio volumio[1313]: error: updateQueue error: null
Dec 18 10:03:43 volumio volumio[1313]: SPOTIFY: SETTING SPOTIFY VOLUME 41
Dec 18 10:03:43 volumio volumio[1313]: info: Sending Spotify command with payload to local API: /player/volume
Dec 18 10:03:44 volumio volumio[1313]: info: TidalConnect service stoped!
Dec 18 10:03:44 volumio volumio[1313]: info: TidalConnect service stoped!
Dec 18 10:03:44 volumio volumio[1313]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Dec 18 10:03:44 volumio volumio[1313]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Dec 18 10:03:44 volumio sudo[11535]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Dec 18 10:03:44 volumio sudo[11535]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:44 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service.
Dec 18 10:03:44 volumio sudo[11535]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:45 volumio volumio[1313]: info: TidalConnect service stoped!
Dec 18 10:03:45 volumio volumio[1313]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Dec 18 10:03:45 volumio volumio[1313]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Dec 18 10:03:45 volumio sudo[11549]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Dec 18 10:03:45 volumio sudo[11549]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:45 volumio volumio[1313]: info: TidalConnect service stoped!
Dec 18 10:03:45 volumio sudo[11549]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:45 volumio volumio[1313]: info: Executing endpoint tc_getconfig
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Dec 18 10:03:45 volumio vtcs[11538]: STARTING TidalConnect services, version: 1.5.2.56
Dec 18 10:03:45 volumio vtcs[11538]: STARTED TidalConnect services.
Dec 18 10:03:45 volumio volumio[1313]: info: Executing endpoint tc_connect
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Dec 18 10:03:45 volumio volumio[1313]: info: Connecting to TidalConnect
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::servicePushState
Dec 18 10:03:45 volumio volumio[1313]: info: CoreStateMachine::pushState
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::volumioPushState
Dec 18 10:03:45 volumio volumio[1313]: info: MRS: Pushing multiroomSync output update for this device
Dec 18 10:03:45 volumio volumio[1313]: info: MRS: Pushing multiroomSync output
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:45 volumio volumio[1313]: info: CorePlayQueue::getTrack 0
Dec 18 10:03:45 volumio volumio[1313]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received tidalconnect
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::servicePushState
Dec 18 10:03:45 volumio volumio[1313]: info: CoreStateMachine::pushState
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::volumioPushState
Dec 18 10:03:45 volumio volumio[1313]: info: MRS: Pushing multiroomSync output update for this device
Dec 18 10:03:45 volumio volumio[1313]: info: MRS: Pushing multiroomSync output
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:45 volumio volumio[1313]: info: CorePlayQueue::getTrack 0
Dec 18 10:03:45 volumio volumio[1313]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received tidalconnect
Dec 18 10:03:45 volumio volumio[1313]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Dec 18 10:03:45 volumio volumio[1313]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Dec 18 10:03:45 volumio volumio[1313]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.tuQ60T4OQ0PBAafQhb19T61FX1X2.f55075054c2192eb87872aab03d7b1b8.state.status'
Dec 18 10:03:45 volumio volumio[1313]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.tuQ60T4OQ0PBAafQhb19T61FX1X2.f55075054c2192eb87872aab03d7b1b8.state.status'
Dec 18 10:03:45 volumio volumio[1313]: info: TidalConnect service stoped!
Dec 18 10:03:45 volumio volumio[1313]: info: TidalConnect service stoped!
Dec 18 10:03:45 volumio volumio[1313]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Dec 18 10:03:45 volumio volumio[1313]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Dec 18 10:03:45 volumio sudo[11575]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Dec 18 10:03:45 volumio sudo[11575]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:45 volumio sudo[11575]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Dec 18 10:03:45 volumio volumio[1313]: info: CoreStateMachine::getcurrentVolume
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::volumioRetrievevolume
Dec 18 10:03:45 volumio volumio[1313]: info: VolumeController:: Volume=41 Mute =false
Dec 18 10:03:45 volumio volumio[1313]: info: CoreStateMachine::pushState
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::volumioPushState
Dec 18 10:03:45 volumio volumio[1313]: info: MRS: Pushing multiroomSync output update for this device
Dec 18 10:03:45 volumio volumio[1313]: info: MRS: Pushing multiroomSync output
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:45 volumio volumio[1313]: info: CoreStateMachine::updateTrackBlock
Dec 18 10:03:45 volumio volumio[1313]: info: CorePlayQueue::getTrackBlock
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::volumioRetrievevolume
Dec 18 10:03:45 volumio volumio[1313]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Dec 18 10:03:45 volumio volumio[1313]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.tuQ60T4OQ0PBAafQhb19T61FX1X2.f55075054c2192eb87872aab03d7b1b8.state.status'
Dec 18 10:03:45 volumio volumio[1313]: info: VolumeController:: Volume=41 Mute =false
Dec 18 10:03:45 volumio volumio[1313]: info: CoreStateMachine::pushState
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::volumioPushState
Dec 18 10:03:45 volumio volumio[1313]: info: MRS: Pushing multiroomSync output update for this device
Dec 18 10:03:45 volumio volumio[1313]: info: MRS: Pushing multiroomSync output
Dec 18 10:03:45 volumio volumio[1313]: info: CoreCommandRouter::volumioGetState
Dec 18 10:03:45 volumio volumio[1313]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41
Dec 18 10:03:45 volumio volumio[1313]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.tuQ60T4OQ0PBAafQhb19T61FX1X2.f55075054c2192eb87872aab03d7b1b8.state.status'
Dec 18 10:03:46 volumio sudo[11583]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Dec 18 10:03:46 volumio sudo[11583]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:46 volumio sudo[11585]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Dec 18 10:03:46 volumio sudo[11585]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 18 10:03:46 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service...
Dec 18 10:03:46 volumio systemd[1]: mpd_monitor.service: Deactivated successfully.
Dec 18 10:03:46 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service.
Dec 18 10:03:46 volumio systemd[1]: mpd_monitor.service: Consumed 1.042s CPU time.
Dec 18 10:03:46 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service.
Dec 18 10:03:46 volumio sudo[11585]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:46 volumio sudo[11583]: pam_unix(sudo:session): session closed for user root
Dec 18 10:03:46 volumio mpd_monitor.sh[11588]: MPD Monitor Service: Starting MPD Monitor Service
Dec 18 10:03:46 volumio volumio[1313]: info: Successfully started MPD Monitor
Dec 18 10:03:46 volumio volumio[1313]: info: Successfully started MPD Monitor
Dec 18 10:03:47 volumio volumio[1313]: info: TidalConnect service started!
Dec 18 10:03:48 volumio volumio[1313]: info: TidalConnect service started!
Dec 18 10:03:48 volumio volumio[1313]: info: TidalConnect service started!
Dec 18 10:03:49 volumio volumio[1313]: info: CoreCommandRouter::volumioGetQueue
Dec 18 10:03:49 volumio volumio[1313]: info: CoreStateMachine::getQueue
Dec 18 10:03:49 volumio volumio[1313]: info: CorePlayQueue::getQueue
Dec 18 10:03:51 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 18 10:03:51 volumio volumio[1313]: info: CURURI: music-library
Dec 18 10:03:51 volumio volumio[1313]: info: Preload queue cleared
Dec 18 10:03:52 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 18 10:03:52 volumio volumio[1313]: info: CURURI: music-library/NAS
Dec 18 10:03:52 volumio volumio[1313]: info: Preload queue cleared
Dec 18 10:03:53 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 18 10:03:53 volumio volumio[1313]: info: CURURI: music-library/NAS/Public
Dec 18 10:03:53 volumio volumio[1313]: info: Preload queue cleared
Dec 18 10:03:55 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 18 10:03:55 volumio volumio[1313]: info: CURURI: music-library/NAS/Public/Massive Attack Discography + EPs and Singles (1991-2006)
Dec 18 10:03:55 volumio volumio[1313]: info: Preload queue cleared
Dec 18 10:04:01 volumio volumio[1313]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 18 10:04:01 volumio volumio[1313]: info: CURURI: music-library/NAS/Public/Santana
Dec 18 10:04:02 volumio volumio[1313]: info: Preload queue cleared
Dec 18 10:04:08 volumio volumio[1313]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 18 10:04:08 volumio volumio[1313]: info: CoreStateMachine::ClearQueue
Dec 18 10:04:08 volumio volumio[1313]: info: CoreStateMachine::stop
Dec 18 10:04:08 volumio volumio[1313]: info: CoreStateMachine::serviceStop
Dec 18 10:04:08 volumio volumio[1313]: info: Received STOP, but no service to execute it
Dec 18 10:04:08 volumio volumio[1313]: info: CorePlayQueue::clearPlayQueue
Dec 18 10:04:08 volumio volumio[1313]: info: CorePlayQueue::saveQueue
Dec 18 10:04:08 volumio volumio[1313]: info: CoreCommandRouter::volumioPushQueue
Dec 18 10:04:08 volumio volumio[1313]: info: CoreStateMachine::addQueueItems
Dec 18 10:04:08 volumio volumio[1313]: info: CorePlayQueue::addQueueItems
Dec 18 10:04:08 volumio volumio[1313]: info: Preload queue cleared
Dec 18 10:04:08 volumio volumio[1313]: info: Adding Item to queue: music-library/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup
Dec 18 10:04:08 volumio volumio[1313]: info: Exploding uri music-library/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup in service mpd
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F01.%20(Da%20Le)%20Yaleo.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/01. (Da Le) Yaleo.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana%20feat.%20Dave%20Matthews/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F02.%20Love%20of%20My%20Life.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/02. Love of My Life.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana%20feat.%20Everlast/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F03.%20Put%20Your%20Lights%20On.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/03. Put Your Lights On.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F04.%20Africa%20Bamba.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/04. Africa Bamba.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana%20feat.%20Rob%20Thomas/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F05.%20Smooth.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/05. Smooth.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana%20feat.%20Lauryn%20Hill%20%26%20Cee%E2%80%90Lo/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F06.%20Do%20You%20Like%20the%20Way.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/06. Do You Like the Way.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F07.%20Maria%20Maria.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/07. Maria Maria.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F08.%20Migra.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/08. Migra.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana%20feat.%20Man%C3%A1/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F09.%20Coraz%C3%B3n%20espinado.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/09. Corazón espinado.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana%20feat.%20Eagle%E2%80%90Eye%20Cherry/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F10.%20Wishing%20It%20Was.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/10. Wishing It Was.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F11.%20El%20farol.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/11. El farol.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F12.%20Primavera.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/12. Primavera.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana%20feat.%20Eric%20Clapton%20%2F%20Santana/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2F13.%20The%20Calling%20_%20Day%20of%20Celebration.flac&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/13. The Calling _ Day of Celebration.flac
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana%20feat.%20Dave%20Matthews/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2FSantana%20-%20Supernatural.cue&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/Santana - Supernatural.cue
Dec 18 10:04:08 volumio volumio[1313]: info: ALBUMART /albumart?cacheid=194&web=Santana%20feat.%20Everlast/Supernatural/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSantana%2FSantana%20-%20Supernatural%20(1999)%20FLAC%20Soup%2FSantana%20-%20Supernatural.cue&metadata=false
Dec 18 10:04:08 volumio volumio[1313]: info: URI /mnt/NAS/Public/Santana/Santana - Supernatural (1999) FLAC Soup/Santana - Supernatural.cue
Dec 18 10:04:08 volumio volumio[1313]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 18 10:04:08 volumio volumio[1313]: Error: Unable to resolve or reject the same promise twice
Dec 18 10:04:08 volumio volumio[1313]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Dec 18 10:04:08 volumio volumio[1313]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21
Dec 18 10:04:08 volumio volumio[1313]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Dec 18 10:04:08 volumio volumio[1313]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Dec 18 10:04:08 volumio volumio[1313]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Dec 18 10:04:08 volumio volumio[1313]: at Socket.emit (node:events:514:28)
Dec 18 10:04:08 volumio volumio[1313]: at addChunk (node:internal/streams/readable:343:12)
Dec 18 10:04:08 volumio volumio[1313]: at readableAddChunk (node:internal/streams/readable:312:11)
Dec 18 10:04:08 volumio volumio[1313]: at Readable.push (node:internal/streams/readable:253:10)
Dec 18 10:04:08 volumio volumio[1313]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23)
Dec 18 10:04:08 volumio volumio[1313]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 18 10:04:08 volumio sudo[11654]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-18 10:03'
Dec 18 10:04:08 volumio sudo[11654]: 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"