-- Logs begin at Mon 2025-05-12 00:26:53 CEST, end at Mon 2025-05-12 00:37:56 CEST. -- May 12 00:36:02 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 00:36:02 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 00:36:02 volumio-laci volumio[1102]: info: Discovery: Getting this device information May 12 00:36:02 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:36:02 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 00:36:16 volumio-laci ntpd[1686]: 81.0.124.253 local addr 192.168.0.21 -> May 12 00:36:26 volumio-laci ntpd[1686]: 195.228.75.149 local addr 192.168.0.21 -> May 12 00:36:32 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 00:36:32 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 00:36:32 volumio-laci volumio[1102]: info: Discovery: Getting this device information May 12 00:36:32 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:36:32 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 00:37:02 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 00:37:02 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 00:37:02 volumio-laci volumio[1102]: info: Discovery: Getting this device information May 12 00:37:02 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:02 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 00:37:04 volumio-laci volumio[1102]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 12 00:37:04 volumio-laci volumio[1102]: info: Preparing to save Alsa Options, stopping services first May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPause May 12 00:37:04 volumio-laci volumio[1102]: info: CoreStateMachine::pause May 12 00:37:04 volumio-laci volumio[1102]: info: Saving Audio Output to: {"output_device":{"value":"0,0","label":"Analog Out"}} May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 12 00:37:04 volumio-laci volumio[1102]: No protocol specified May 12 00:37:04 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:04 volumio-laci volumio[1102]: No protocol specified May 12 00:37:04 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 12 00:37:04 volumio-laci volumio[1102]: info: Found match in Cards Database: setting mixer for card Analog Out May 12 00:37:04 volumio-laci volumio[1102]: info: QobuzConnect: setDeactiveState invoked May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:04 volumio-laci vtcs[4711]: [2025-05-12 00:37:04.165] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected May 12 00:37:04 volumio-laci vtcs[4711]: [2025-05-12 00:37:04.165] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE May 12 00:37:04 volumio-laci sudo[4952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 12 00:37:04 volumio-laci sudo[4952]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci systemd[1]: Stopping Volumio Tidal Connect Service... May 12 00:37:04 volumio-laci systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM May 12 00:37:04 volumio-laci systemd[1]: vtcs.service: Succeeded. May 12 00:37:04 volumio-laci systemd[1]: Stopped Volumio Tidal Connect Service. May 12 00:37:04 volumio-laci sudo[4952]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci volumio[1102]: No protocol specified May 12 00:37:04 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:04 volumio-laci volumio[1102]: info: Setting default mixerSoftMaster for Softvolume device May 12 00:37:04 volumio-laci volumio[1102]: info: QobuzConnect: setDeactiveState invoked May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:04 volumio-laci sudo[4958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 12 00:37:04 volumio-laci sudo[4958]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci sudo[4958]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci volumio[1102]: No protocol specified May 12 00:37:04 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 12 00:37:04 volumio-laci volumio[1102]: info: Updating Volume Controller Parameters: Device: 0,0 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 20 May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 12 00:37:04 volumio-laci volumio[1102]: info: Disabling external Volume Control May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::getUIConfigOnPlugin May 12 00:37:04 volumio-laci volumio[1102]: info: Enable softmixer device for audio device undefined May 12 00:37:04 volumio-laci sudo[4971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 12 00:37:04 volumio-laci sudo[4971]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci sudo[4974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 12 00:37:04 volumio-laci sudo[4974]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci sudo[4971]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: QobuzConnect: Setting Qobuz Connect card as outputdevicealsadevice to 0 May 12 00:37:04 volumio-laci sudo[4974]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci sudo[4982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect May 12 00:37:04 volumio-laci sudo[4982]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: QobuzConnect: Setting Qobuz Connect card as outputdevicealsadevice to 0 May 12 00:37:04 volumio-laci volumio[1102]: ------------------------------------ BT MESSAGE: BT STATUS: running May 12 00:37:04 volumio-laci sudo[4989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect May 12 00:37:04 volumio-laci sudo[4989]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:04 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:04 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:04 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified May 12 00:37:04 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:04 volumio-laci volumio[1102]: info: Software Volume ALSA configuration written May 12 00:37:04 volumio-laci volumio[1102]: info: Preparing to generate the ALSA configuration file May 12 00:37:04 volumio-laci systemd[1]: Started Volumio Qobuz Connect Service. May 12 00:37:04 volumio-laci sudo[4982]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci systemd[1]: Stopping Volumio Qobuz Connect Service... May 12 00:37:04 volumio-laci systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT May 12 00:37:04 volumio-laci systemd[1]: qobuz-connect.service: Succeeded. May 12 00:37:04 volumio-laci systemd[1]: Stopped Volumio Qobuz Connect Service. May 12 00:37:04 volumio-laci systemd[1]: Started Volumio Qobuz Connect Service. May 12 00:37:04 volumio-laci sudo[4989]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci volumio[1102]: No protocol specified May 12 00:37:04 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 12 00:37:04 volumio-laci volumio[1102]: No protocol specified May 12 00:37:04 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 12 00:37:04 volumio-laci volumio[1102]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 12 00:37:04 volumio-laci volumio[1102]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 12 00:37:04 volumio-laci volumio[1102]: info: Reading ALSA contributions from plugins. May 12 00:37:04 volumio-laci volumio[1102]: ------------------------------------ BT MESSAGE: BT STATUS: running May 12 00:37:04 volumio-laci volumio[1102]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 12 00:37:04 volumio-laci volumio[1102]: info: Executing endpoint qc_getconfig May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 12 00:37:04 volumio-laci qobuz-connect[4991]: 20250512 00:37:04.317 [4991.4991] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 12 00:37:04 volumio-laci volumio[1102]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 12 00:37:04 volumio-laci volumio[1102]: info: QobuzConnect: QOBUZ Connect daemon connected May 12 00:37:04 volumio-laci volumio[1102]: info: Asound.conf file unchanged, so no further update is needed May 12 00:37:04 volumio-laci volumio[1102]: info: Output device has changed, restarting MPD May 12 00:37:04 volumio-laci qobuz-connect[4991]: 20250512 00:37:04.319 [4991.4991] INFO VolumeManager: [0x55d3dd9b55e0]: Setting new playback volume: 75 May 12 00:37:04 volumio-laci qobuz-connect[4991]: 20250512 00:37:04.319 [4991.4991] INFO VolumeManager: [0x55d3dd9b55e0]: Setting new mute state: 0 May 12 00:37:04 volumio-laci qobuz-connect[4991]: 20250512 00:37:04.319 [4991.4991] INFO QobuzConnect: [0x55d3dd9b6800]: Client initialized! May 12 00:37:04 volumio-laci qobuz-connect[4991]: 20250512 00:37:04.319 [4991.4991] INFO SampleApp: Starting Avahi advertising, name: volumio-laci, service name: _qobuz-connect._tcp May 12 00:37:04 volumio-laci qobuz-connect[4991]: 20250512 00:37:04.322 [4991.4991] INFO LocalConfigManager: [0x55d3dd9b48d0]: Starting Local Configuration server May 12 00:37:04 volumio-laci qobuz-connect[4991]: 20250512 00:37:04.322 [4991.4991] INFO SampleApp: Starting Local configuration server May 12 00:37:04 volumio-laci qobuz-connect[4991]: 20250512 00:37:04.322 [4991.4991] INFO SampleApp: Connected to UNIX socket client 0x55d3dd99c280 May 12 00:37:04 volumio-laci sudo[4999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 12 00:37:04 volumio-laci sudo[4999]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci sudo[4999]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci volumio[1102]: info: Output device has changed, restarting Shairport Sync May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 00:37:04 volumio-laci sudo[5003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 12 00:37:04 volumio-laci sudo[5003]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci systemd[1]: Stopping Music Player Daemon... May 12 00:37:04 volumio-laci systemd[1]: mpd.service: Succeeded. May 12 00:37:04 volumio-laci systemd[1]: Stopped Music Player Daemon. May 12 00:37:04 volumio-laci volumio[1102]: No protocol specified May 12 00:37:04 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:04 volumio-laci volumio[1102]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 00:37:04 volumio-laci volumio[1102]: No protocol specified May 12 00:37:04 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:04 volumio-laci volumio[1102]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: QobuzConnect: setDeactiveState invoked May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:04 volumio-laci sudo[5012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 12 00:37:04 volumio-laci sudo[5012]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci systemd[1]: Starting Music Player Daemon... May 12 00:37:04 volumio-laci sudo[5015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 12 00:37:04 volumio-laci sudo[5015]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci sudo[5012]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 00:37:04 volumio-laci sudo[5015]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: QobuzConnect: Setting Qobuz Connect card as outputdevicealsadevice to 0 May 12 00:37:04 volumio-laci volumio[1102]: ------------------------------------ BT MESSAGE: BT STATUS: running May 12 00:37:04 volumio-laci volumio[1102]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 12 00:37:04 volumio-laci volumio[1102]: ------------------------------------ BT MESSAGE: BT STATUS: running May 12 00:37:04 volumio-laci sudo[5024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect May 12 00:37:04 volumio-laci sudo[5024]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci volumio[1102]: info: MPD Permissions set May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 00:37:04 volumio-laci systemd[1]: Stopping Volumio Qobuz Connect Service... May 12 00:37:04 volumio-laci qobuz-connect[4991]: 20250512 00:37:04.391 [4991.4991] INFO SampleApp: Stopping Local configuration server May 12 00:37:04 volumio-laci sudo[5008]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 12 00:37:04 volumio-laci sudo[5008]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci sudo[5008]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 12 00:37:04 volumio-laci qobuz-connect[4991]: 20250512 00:37:04.402 [4991.4991] INFO SampleApp: shat down connection on UNIX socket May 12 00:37:04 volumio-laci systemd[1]: qobuz-connect.service: Succeeded. May 12 00:37:04 volumio-laci systemd[1]: Stopped Volumio Qobuz Connect Service. May 12 00:37:04 volumio-laci systemd[1]: Started Volumio Qobuz Connect Service. May 12 00:37:04 volumio-laci sudo[5024]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 00:37:04 volumio-laci volumio[1102]: ------------------------------------ BT MESSAGE: BT STATUS: running May 12 00:37:04 volumio-laci volumio[1102]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 12 00:37:04 volumio-laci volumio[1102]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 12 00:37:04 volumio-laci volumio[1102]: info: QobuzConnect: setDeactiveState invoked May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:04 volumio-laci volumio[1102]: info: Starting Shairport Sync May 12 00:37:04 volumio-laci volumio[1102]: info: Executing endpoint qc_getconfig May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 12 00:37:04 volumio-laci qobuz-connect[5033]: 20250512 00:37:04.422 [5033.5033] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 12 00:37:04 volumio-laci volumio[1102]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 12 00:37:04 volumio-laci volumio[1102]: info: QobuzConnect: QOBUZ Connect daemon connected May 12 00:37:04 volumio-laci qobuz-connect[5033]: 20250512 00:37:04.424 [5033.5033] INFO VolumeManager: [0x55d3bffbf5e0]: Setting new playback volume: 75 May 12 00:37:04 volumio-laci qobuz-connect[5033]: 20250512 00:37:04.424 [5033.5033] INFO VolumeManager: [0x55d3bffbf5e0]: Setting new mute state: 0 May 12 00:37:04 volumio-laci qobuz-connect[5033]: 20250512 00:37:04.424 [5033.5033] INFO QobuzConnect: [0x55d3bffc0800]: Client initialized! May 12 00:37:04 volumio-laci qobuz-connect[5033]: 20250512 00:37:04.424 [5033.5033] INFO SampleApp: Starting Avahi advertising, name: volumio-laci, service name: _qobuz-connect._tcp May 12 00:37:04 volumio-laci sudo[5037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 00:37:04 volumio-laci sudo[5037]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:04 volumio-laci qobuz-connect[5033]: 20250512 00:37:04.427 [5033.5033] INFO LocalConfigManager: [0x55d3bffbe8d0]: Starting Local Configuration server May 12 00:37:04 volumio-laci qobuz-connect[5033]: 20250512 00:37:04.427 [5033.5033] INFO SampleApp: Starting Local configuration server May 12 00:37:04 volumio-laci qobuz-connect[5033]: 20250512 00:37:04.427 [5033.5033] INFO SampleApp: Connected to UNIX socket client 0x55d3bffa6280 May 12 00:37:04 volumio-laci systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 12 00:37:04 volumio-laci systemd[1]: shairport-sync.service: Succeeded. May 12 00:37:04 volumio-laci volumio[1102]: ------------------------------------ BT MESSAGE: BT STATUS: running May 12 00:37:04 volumio-laci systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 12 00:37:04 volumio-laci volumio[1102]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 12 00:37:04 volumio-laci systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 12 00:37:04 volumio-laci sudo[5037]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci volumio[1102]: info: Shairport-Sync Started May 12 00:37:04 volumio-laci qobuz-connect[5033]: 20250512 00:37:04.572 [5033.5033] INFO SampleApp: Playback volume changed: 75 May 12 00:37:04 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:04 volumio-laci mpd[5028]: May 12 00:37 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 12 00:37:04 volumio-laci systemd[1]: Started Music Player Daemon. May 12 00:37:04 volumio-laci sudo[5003]: pam_unix(sudo:session): session closed for user root May 12 00:37:04 volumio-laci volumio[1102]: error: updateQueue error: null May 12 00:37:07 volumio-laci volumio[1102]: info: TidalConnect service stoped! May 12 00:37:07 volumio-laci volumio[1102]: info: TidalConnect service stoped! May 12 00:37:07 volumio-laci volumio[1102]: info: TidalConnect service stoped! May 12 00:37:07 volumio-laci volumio[1102]: info: TidalConnect service stoped! May 12 00:37:07 volumio-laci volumio[1102]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 12 00:37:07 volumio-laci volumio[1102]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 12 00:37:07 volumio-laci volumio[1102]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 12 00:37:07 volumio-laci volumio[1102]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 12 00:37:07 volumio-laci sudo[5063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 12 00:37:07 volumio-laci sudo[5063]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:07 volumio-laci sudo[5066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 12 00:37:07 volumio-laci sudo[5066]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:07 volumio-laci systemd[1]: Started Volumio Tidal Connect Service. May 12 00:37:07 volumio-laci sudo[5063]: pam_unix(sudo:session): session closed for user root May 12 00:37:07 volumio-laci sudo[5066]: pam_unix(sudo:session): session closed for user root May 12 00:37:07 volumio-laci volumio[1102]: info: Executing endpoint tc_getconfig May 12 00:37:07 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 12 00:37:07 volumio-laci vtcs[5067]: STARTING TidalConnect services, version: 1.4.0.34 May 12 00:37:07 volumio-laci volumio[1102]: info: TidalConnect service stoped! May 12 00:37:07 volumio-laci vtcs[5067]: STARTED TidalConnect services. May 12 00:37:07 volumio-laci volumio[1102]: info: Executing endpoint tc_connect May 12 00:37:07 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 12 00:37:07 volumio-laci volumio[1102]: info: Connecting to TidalConnect May 12 00:37:07 volumio-laci volumio[1102]: info: CoreCommandRouter::servicePushState May 12 00:37:07 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:07 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:07 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:07 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:07 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:07 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 4 May 12 00:37:07 volumio-laci volumio[1102]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect May 12 00:37:07 volumio-laci volumio[1102]: info: CoreCommandRouter::servicePushState May 12 00:37:07 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:07 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:07 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:07 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:07 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:07 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 4 May 12 00:37:07 volumio-laci volumio[1102]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect May 12 00:37:07 volumio-laci volumio[1102]: info: TidalConnect service stoped! May 12 00:37:07 volumio-laci volumio[1102]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 12 00:37:07 volumio-laci volumio[1102]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 12 00:37:07 volumio-laci sudo[5097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 12 00:37:07 volumio-laci sudo[5097]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 00:37:07 volumio-laci sudo[5097]: pam_unix(sudo:session): session closed for user root May 12 00:37:08 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 12 00:37:08 volumio-laci volumio[1102]: info: CoreStateMachine::getcurrentVolume May 12 00:37:08 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioRetrievevolume May 12 00:37:08 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:08 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:08 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:08 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:08 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:08 volumio-laci volumio[1102]: info: CoreStateMachine::updateTrackBlock May 12 00:37:08 volumio-laci volumio[1102]: info: CorePlayQueue::getTrackBlock May 12 00:37:08 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioRetrievevolume May 12 00:37:08 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:08 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:08 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:08 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:08 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:10 volumio-laci volumio[1102]: info: TidalConnect service started! May 12 00:37:10 volumio-laci volumio[1102]: info: TidalConnect service started! May 12 00:37:10 volumio-laci volumio[1102]: info: TidalConnect service started! May 12 00:37:15 volumio-laci volumio[1102]: info: Preload queue cleared May 12 00:37:15 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioReplaceandPlayItems May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::ClearQueue May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::stop May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::updateTrackBlock May 12 00:37:15 volumio-laci volumio[1102]: info: CorePlayQueue::getTrackBlock May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::stPlaybackTimer May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:15 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 4 May 12 00:37:15 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:15 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:15 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:15 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:15 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:15 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 4 May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::serviceStop May 12 00:37:15 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 4 May 12 00:37:15 volumio-laci volumio[1102]: info: CoreCommandRouter::serviceStop May 12 00:37:15 volumio-laci volumio[1102]: info: [1747003035797] ControllerTidal::stop May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::setConsumeUpdateService mpd May 12 00:37:15 volumio-laci volumio[1102]: info: ControllerMpd::stop May 12 00:37:15 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand stop May 12 00:37:15 volumio-laci volumio[1102]: info: CorePlayQueue::clearPlayQueue May 12 00:37:15 volumio-laci volumio[1102]: info: CorePlayQueue::saveQueue May 12 00:37:15 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushQueue May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::addQueueItems May 12 00:37:15 volumio-laci volumio[1102]: info: CorePlayQueue::addQueueItems May 12 00:37:15 volumio-laci volumio[1102]: info: Preload queue cleared May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/277328065 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/277328065 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/266224094 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/266224094 May 12 00:37:15 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushQueue May 12 00:37:15 volumio-laci volumio[1102]: info: CorePlayQueue::saveQueue May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::updateTrackBlock May 12 00:37:15 volumio-laci volumio[1102]: info: CorePlayQueue::getTrackBlock May 12 00:37:15 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPlay May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::play index 1 May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::addQueueItems May 12 00:37:15 volumio-laci volumio[1102]: info: CorePlayQueue::addQueueItems May 12 00:37:15 volumio-laci volumio[1102]: info: Preload queue cleared May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/38114505 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/38114505 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/114542270 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/114542270 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/145940609 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/145940609 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/2906755 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/2906755 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/57430666 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/57430666 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/15666682 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/15666682 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/4477234 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/4477234 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/60896224 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/60896224 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/8055927 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/8055927 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/4523609 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/4523609 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/9625220 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/9625220 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/389598152 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/389598152 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/281935013 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/281935013 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/201791718 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/201791718 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/287843808 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/287843808 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/234629511 May 12 00:37:15 volumio-laci volumio[1102]: info: Exploding uri tidal://mymusic/tracks/az/234629511 in service tidal May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/311942213 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/311942213 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/390388403 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/390388403 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/11347408 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/11347408 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/91580145 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/91580145 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/2906752 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/2906752 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/21591576 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/21591576 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/82811591 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/82811591 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/159554690 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/159554690 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/134186880 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/134186880 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/3284755 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/3284755 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/2111713 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/2111713 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/373556341 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/373556341 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/385515144 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/385515144 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/4477235 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/4477235 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/21676846 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/21676846 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/84612028 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/84612028 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/313877940 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/313877940 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/77623769 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/77623769 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/389785992 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/389785992 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/390492731 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/390492731 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/21676851 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/21676851 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/382616478 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/382616478 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/610076 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/610076 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/40693476 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/40693476 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/13371563 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/13371563 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/91580142 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/91580142 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/193251990 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/193251990 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/77724043 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/77724043 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/391222385 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/391222385 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/389650608 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/389650608 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/392042007 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/392042007 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/280622756 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/280622756 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/8669086 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/8669086 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/2906751 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/2906751 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/364352312 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/364352312 May 12 00:37:15 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/2463210 May 12 00:37:15 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/2463210 May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::stop May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::play index undefined May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 00:37:15 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 1 May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::startPlaybackTimer May 12 00:37:15 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 1 May 12 00:37:15 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetVisibleSources May 12 00:37:15 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 00:37:15 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 12 00:37:15 volumio-laci volumio[1102]: info: [1747003035808] ControllerTidal::clearAddPlayTrack May 12 00:37:15 volumio-laci volumio[1102]: info: Getting stream with soundQuality LOSSLESS May 12 00:37:15 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand stop May 12 00:37:15 volumio-laci volumio[1102]: info: sendMpdCommand stop took 14 milliseconds May 12 00:37:15 volumio-laci volumio[1102]: info: sendMpdCommand stop took 3 milliseconds May 12 00:37:15 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand clear May 12 00:37:15 volumio-laci volumio[1102]: info: May 12 00:37:15 volumio-laci volumio[1102]: ---------------------------- MPD announces system playlist update May 12 00:37:15 volumio-laci volumio[1102]: info: Ignoring MPD Status Update May 12 00:37:15 volumio-laci volumio[1102]: info: sendMpdCommand clear took 0 milliseconds May 12 00:37:15 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/266224094&soundQuality=LOSSLESS" May 12 00:37:15 volumio-laci volumio[1102]: error: updateQueue error: null May 12 00:37:15 volumio-laci volumio[1102]: info: May 12 00:37:15 volumio-laci volumio[1102]: ---------------------------- MPD announces system playlist update May 12 00:37:15 volumio-laci volumio[1102]: info: Ignoring MPD Status Update May 12 00:37:15 volumio-laci volumio[1102]: info: ------------------------------ 1ms May 12 00:37:15 volumio-laci volumio[1102]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/266224094&soundQuality=LOSSLESS" took 1 milliseconds May 12 00:37:15 volumio-laci volumio[1102]: info: CoreStateMachine::setConsumeUpdateService mpd May 12 00:37:15 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand play May 12 00:37:15 volumio-laci volumio[1102]: info: ------------------------------ 0ms May 12 00:37:15 volumio-laci volumio[1102]: info: sendMpdCommand play took 1 milliseconds May 12 00:37:15 volumio-laci volumio[1102]: STREAMING PROXY: Handling url /?data=tidal://song/266224094&soundQuality=LOSSLESS May 12 00:37:15 volumio-laci volumio[1102]: info: Executing endpoint getStreamUrltidal May 12 00:37:15 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 12 00:37:16 volumio-laci volumio[1102]: info: explodeTIDALUri took 250 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: error: TIDAL Browse Error: failed to get track: got 404: {"status":404,"subStatus":2001,"userMessage":"Track [234629511] not found"} May 12 00:37:16 volumio-laci volumio[1102]: error: Commandrouter: Cannot explode uri tidal://mymusic/tracks/az/234629511 from service tidal: failed to get track: got 404: {"status":404,"subStatus":2001,"userMessage":"Track [234629511] not found"} May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushQueue May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::saveQueue May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::updateTrackBlock May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::getTrackBlock May 12 00:37:16 volumio-laci volumio[1102]: info: getStreamUrl took 516 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEidmMDQ3ZmIwYWMzZGE0ZDcwZjljMzliN2QwMTExZGM2MF82MS5tcDQ/0.flac?token=1747006636~YTc2ZTczNjE3ODlkYjM2ZGZjMTkwNzA1YmQyOTA0NTA1ZTJhNDlkYw== May 12 00:37:16 volumio-laci volumio[1102]: STREAMING PROXY: Response: 200, length: 33551715 May 12 00:37:16 volumio-laci volumio[1102]: info: May 12 00:37:16 volumio-laci volumio[1102]: ---------------------------- MPD announces state update: player May 12 00:37:16 volumio-laci volumio[1102]: info: ControllerMpd::getState May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand status May 12 00:37:16 volumio-laci volumio[1102]: info: May 12 00:37:16 volumio-laci volumio[1102]: ---------------------------- MPD announces state update: player May 12 00:37:16 volumio-laci volumio[1102]: info: sendMpdCommand status took 16 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: info: ControllerMpd::getState May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand status May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::parseState May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 00:37:16 volumio-laci volumio[1102]: info: sendMpdCommand status took 1 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: info: sendMpdCommand playlistinfo took 0 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::parseState May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::parseTrackInfo May 12 00:37:16 volumio-laci volumio[1102]: info: ControllerMpd::pushState May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::servicePushState May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 1 May 12 00:37:16 volumio-laci volumio[1102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"266224094&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/266224094&soundQuality=LOSSLESS","trackType":"tidal"} May 12 00:37:16 volumio-laci volumio[1102]: verbose: CURRENT POSITION 1 May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::syncState stateService play May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::syncState currentStatus stop May 12 00:37:16 volumio-laci volumio[1102]: info: ------------------------------ 18ms May 12 00:37:16 volumio-laci volumio[1102]: info: sendMpdCommand playlistinfo took 1 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::parseTrackInfo May 12 00:37:16 volumio-laci volumio[1102]: info: ControllerMpd::pushState May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::servicePushState May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 1 May 12 00:37:16 volumio-laci volumio[1102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1092,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"515 Kbps","isStreaming":false,"title":"266224094&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/266224094&soundQuality=LOSSLESS","trackType":"tidal"} May 12 00:37:16 volumio-laci volumio[1102]: verbose: CURRENT POSITION 1 May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::syncState stateService play May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::syncState currentStatus play May 12 00:37:16 volumio-laci volumio[1102]: info: Received an update from plugin. extracting info from payload May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:16 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:16 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:16 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:16 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:16 volumio-laci volumio[1102]: info: ------------------------------ 4ms May 12 00:37:16 volumio-laci volumio[1102]: info: Preload queue cleared May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioReplaceandPlayItems May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::ClearQueue May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::stop May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::stPlaybackTimer May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::updateTrackBlock May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::getTrackBlock May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 1 May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:16 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:16 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 1 May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::serviceStop May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 1 May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::serviceStop May 12 00:37:16 volumio-laci volumio[1102]: info: [1747003036842] ControllerTidal::stop May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::setConsumeUpdateService mpd May 12 00:37:16 volumio-laci volumio[1102]: info: ControllerMpd::stop May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand stop May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::clearPlayQueue May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::saveQueue May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushQueue May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::addQueueItems May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::addQueueItems May 12 00:37:16 volumio-laci volumio[1102]: info: Preload queue cleared May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/277328065 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/277328065 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/266224094 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/266224094 May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushQueue May 12 00:37:16 volumio-laci volumio[1102]: STREAMING PROXY: Client dropped request, destroying May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::saveQueue May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::updateTrackBlock May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::getTrackBlock May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPlay May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::play index 1 May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::addQueueItems May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::addQueueItems May 12 00:37:16 volumio-laci volumio[1102]: info: Preload queue cleared May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/38114505 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/38114505 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/114542270 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/114542270 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/145940609 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/145940609 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/2906755 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/2906755 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/57430666 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/57430666 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/15666682 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/15666682 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/4477234 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/4477234 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/60896224 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/60896224 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/8055927 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/8055927 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/4523609 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/4523609 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/9625220 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/9625220 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/389598152 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/389598152 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/281935013 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/281935013 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/201791718 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/201791718 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/287843808 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/287843808 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/234629511 May 12 00:37:16 volumio-laci volumio[1102]: info: Exploding uri tidal://mymusic/tracks/az/234629511 in service tidal May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/311942213 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/311942213 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/390388403 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/390388403 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/11347408 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/11347408 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/91580145 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/91580145 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/2906752 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/2906752 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/21591576 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/21591576 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/82811591 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/82811591 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/159554690 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/159554690 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/134186880 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/134186880 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/3284755 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/3284755 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/2111713 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/2111713 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/373556341 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/373556341 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/385515144 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/385515144 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/4477235 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/4477235 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/21676846 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/21676846 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/84612028 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/84612028 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/313877940 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/313877940 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/77623769 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/77623769 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/389785992 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/389785992 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/390492731 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/390492731 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/21676851 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/21676851 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/382616478 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/382616478 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/610076 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/610076 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/40693476 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/40693476 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/13371563 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/13371563 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/91580142 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/91580142 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/193251990 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/193251990 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/77724043 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/77724043 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/391222385 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/391222385 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/389650608 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/389650608 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/392042007 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/392042007 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/280622756 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/280622756 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/8669086 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/8669086 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/2906751 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/2906751 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/364352312 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/364352312 May 12 00:37:16 volumio-laci volumio[1102]: info: Adding Item to queue: tidal://mymusic/tracks/az/2463210 May 12 00:37:16 volumio-laci volumio[1102]: info: Using cached record of: tidal://mymusic/tracks/az/2463210 May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::stop May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::play index undefined May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 1 May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::startPlaybackTimer May 12 00:37:16 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 1 May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetVisibleSources May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 12 00:37:16 volumio-laci volumio[1102]: info: [1747003036851] ControllerTidal::clearAddPlayTrack May 12 00:37:16 volumio-laci volumio[1102]: info: Getting stream with soundQuality LOSSLESS May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand stop May 12 00:37:16 volumio-laci volumio[1102]: info: May 12 00:37:16 volumio-laci volumio[1102]: ---------------------------- MPD announces state update: player May 12 00:37:16 volumio-laci volumio[1102]: info: sendMpdCommand stop took 13 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: info: ControllerMpd::getState May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand status May 12 00:37:16 volumio-laci volumio[1102]: info: sendMpdCommand stop took 4 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand clear May 12 00:37:16 volumio-laci volumio[1102]: info: May 12 00:37:16 volumio-laci volumio[1102]: ---------------------------- MPD announces system playlist update May 12 00:37:16 volumio-laci volumio[1102]: info: Ignoring MPD Status Update May 12 00:37:16 volumio-laci volumio[1102]: info: sendMpdCommand status took 0 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: info: sendMpdCommand clear took 0 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::parseState May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/266224094&soundQuality=LOSSLESS" May 12 00:37:16 volumio-laci volumio[1102]: error: updateQueue error: null May 12 00:37:16 volumio-laci volumio[1102]: info: May 12 00:37:16 volumio-laci volumio[1102]: ---------------------------- MPD announces system playlist update May 12 00:37:16 volumio-laci volumio[1102]: info: Ignoring MPD Status Update May 12 00:37:16 volumio-laci volumio[1102]: info: ------------------------------ 1ms May 12 00:37:16 volumio-laci volumio[1102]: info: sendMpdCommand playlistinfo took 1 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/266224094&soundQuality=LOSSLESS" took 0 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::parseTrackInfo May 12 00:37:16 volumio-laci volumio[1102]: info: CoreStateMachine::setConsumeUpdateService mpd May 12 00:37:16 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand play May 12 00:37:16 volumio-laci volumio[1102]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 12 00:37:16 volumio-laci volumio[1102]: info: ------------------------------ 3ms May 12 00:37:16 volumio-laci volumio[1102]: info: ------------------------------ 1ms May 12 00:37:16 volumio-laci volumio[1102]: info: sendMpdCommand play took 1 milliseconds May 12 00:37:16 volumio-laci volumio[1102]: STREAMING PROXY: Handling url /?data=tidal://song/266224094&soundQuality=LOSSLESS May 12 00:37:16 volumio-laci volumio[1102]: info: Executing endpoint getStreamUrltidal May 12 00:37:16 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI May 12 00:37:17 volumio-laci volumio[1102]: info: explodeTIDALUri took 259 milliseconds May 12 00:37:17 volumio-laci volumio[1102]: error: TIDAL Browse Error: failed to get track: got 404: {"status":404,"subStatus":2001,"userMessage":"Track [234629511] not found"} May 12 00:37:17 volumio-laci volumio[1102]: error: Commandrouter: Cannot explode uri tidal://mymusic/tracks/az/234629511 from service tidal: failed to get track: got 404: {"status":404,"subStatus":2001,"userMessage":"Track [234629511] not found"} May 12 00:37:17 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushQueue May 12 00:37:17 volumio-laci volumio[1102]: info: CorePlayQueue::saveQueue May 12 00:37:17 volumio-laci volumio[1102]: info: CoreStateMachine::updateTrackBlock May 12 00:37:17 volumio-laci volumio[1102]: info: CorePlayQueue::getTrackBlock May 12 00:37:17 volumio-laci volumio[1102]: info: getStreamUrl took 255 milliseconds May 12 00:37:17 volumio-laci volumio[1102]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEidmMDQ3ZmIwYWMzZGE0ZDcwZjljMzliN2QwMTExZGM2MF82MS5tcDQ/0.flac?token=1747006636~YTc2ZTczNjE3ODlkYjM2ZGZjMTkwNzA1YmQyOTA0NTA1ZTJhNDlkYw== May 12 00:37:17 volumio-laci volumio[1102]: STREAMING PROXY: Response: 200, length: 33551715 May 12 00:37:17 volumio-laci volumio[1102]: info: May 12 00:37:17 volumio-laci volumio[1102]: ---------------------------- MPD announces state update: player May 12 00:37:17 volumio-laci volumio[1102]: info: ControllerMpd::getState May 12 00:37:17 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand status May 12 00:37:17 volumio-laci volumio[1102]: info: May 12 00:37:17 volumio-laci volumio[1102]: ---------------------------- MPD announces state update: player May 12 00:37:17 volumio-laci volumio[1102]: info: sendMpdCommand status took 4 milliseconds May 12 00:37:17 volumio-laci volumio[1102]: info: ControllerMpd::getState May 12 00:37:17 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand status May 12 00:37:17 volumio-laci volumio[1102]: verbose: ControllerMpd::parseState May 12 00:37:17 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 00:37:17 volumio-laci volumio[1102]: info: sendMpdCommand status took 0 milliseconds May 12 00:37:17 volumio-laci volumio[1102]: info: sendMpdCommand playlistinfo took 0 milliseconds May 12 00:37:17 volumio-laci volumio[1102]: verbose: ControllerMpd::parseState May 12 00:37:17 volumio-laci volumio[1102]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 00:37:17 volumio-laci volumio[1102]: verbose: ControllerMpd::parseTrackInfo May 12 00:37:17 volumio-laci volumio[1102]: info: ControllerMpd::pushState May 12 00:37:17 volumio-laci volumio[1102]: info: CoreCommandRouter::servicePushState May 12 00:37:17 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 1 May 12 00:37:17 volumio-laci volumio[1102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"266224094&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/266224094&soundQuality=LOSSLESS","trackType":"tidal"} May 12 00:37:17 volumio-laci volumio[1102]: verbose: CURRENT POSITION 1 May 12 00:37:17 volumio-laci volumio[1102]: info: CoreStateMachine::syncState stateService play May 12 00:37:17 volumio-laci volumio[1102]: info: CoreStateMachine::syncState currentStatus stop May 12 00:37:17 volumio-laci volumio[1102]: info: ------------------------------ 5ms May 12 00:37:17 volumio-laci volumio[1102]: info: sendMpdCommand playlistinfo took 1 milliseconds May 12 00:37:17 volumio-laci volumio[1102]: verbose: ControllerMpd::parseTrackInfo May 12 00:37:17 volumio-laci volumio[1102]: info: ControllerMpd::pushState May 12 00:37:17 volumio-laci volumio[1102]: info: CoreCommandRouter::servicePushState May 12 00:37:17 volumio-laci volumio[1102]: info: CorePlayQueue::getTrack 1 May 12 00:37:17 volumio-laci volumio[1102]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"266224094&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/266224094&soundQuality=LOSSLESS","trackType":"tidal"} May 12 00:37:17 volumio-laci volumio[1102]: verbose: CURRENT POSITION 1 May 12 00:37:17 volumio-laci volumio[1102]: info: CoreStateMachine::syncState stateService play May 12 00:37:17 volumio-laci volumio[1102]: info: CoreStateMachine::syncState currentStatus play May 12 00:37:17 volumio-laci volumio[1102]: info: Received an update from plugin. extracting info from payload May 12 00:37:17 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:17 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:17 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:17 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:17 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:17 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:17 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:17 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:17 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:17 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:17 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:17 volumio-laci volumio[1102]: info: ------------------------------ 4ms May 12 00:37:18 volumio-laci volumio[1102]: STREAMING PROXY: Client dropped request, destroying May 12 00:37:22 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume50 May 12 00:37:22 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:22 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:22 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:22 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:22 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:22 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:22 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:22 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:23 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume40 May 12 00:37:23 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:23 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:23 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:23 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:23 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:23 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:23 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:23 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:24 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume25 May 12 00:37:24 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:24 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:24 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:24 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:24 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:24 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:24 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:24 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:24 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume15 May 12 00:37:24 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:24 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:24 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:24 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:24 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:24 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:24 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:24 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:32 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 00:37:32 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 00:37:32 volumio-laci volumio[1102]: info: Discovery: Getting this device information May 12 00:37:32 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:32 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 00:37:35 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume May 12 00:37:35 volumio-laci volumio[1102]: info: Setting Remote Device Volume: http://192.168.0.21 May 12 00:37:35 volumio-laci volumio[1102]: info: May 12 00:37:35 volumio-laci volumio[1102]: ---------------------------- Client requests Volume 35 May 12 00:37:35 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume35 May 12 00:37:35 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:35 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:35 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:35 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:35 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:35 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:35 volumio-laci volumio[1102]: info: Done setting volume on: May 12 00:37:35 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:35 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:36 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume May 12 00:37:36 volumio-laci volumio[1102]: info: Setting Remote Device Volume: http://192.168.0.21 May 12 00:37:36 volumio-laci volumio[1102]: info: May 12 00:37:36 volumio-laci volumio[1102]: ---------------------------- Client requests Volume 58 May 12 00:37:36 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume58 May 12 00:37:36 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:36 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:36 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:36 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:36 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:36 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:36 volumio-laci volumio[1102]: info: Done setting volume on: May 12 00:37:36 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:36 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:38 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume May 12 00:37:38 volumio-laci volumio[1102]: info: Setting Remote Device Volume: http://192.168.0.21 May 12 00:37:38 volumio-laci volumio[1102]: info: May 12 00:37:38 volumio-laci volumio[1102]: ---------------------------- Client requests Volume 26 May 12 00:37:38 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume26 May 12 00:37:38 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:38 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:38 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:38 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:38 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:38 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:38 volumio-laci volumio[1102]: info: Done setting volume on: May 12 00:37:38 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified May 12 00:37:38 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:38 volumio-laci volumio[1102]: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:38 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:38 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume May 12 00:37:38 volumio-laci volumio[1102]: info: Setting Remote Device Volume: http://192.168.0.21 May 12 00:37:38 volumio-laci volumio[1102]: info: May 12 00:37:38 volumio-laci volumio[1102]: ---------------------------- Client requests Volume 14 May 12 00:37:38 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume14 May 12 00:37:38 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:38 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:38 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:38 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:38 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:38 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:38 volumio-laci volumio[1102]: info: Done setting volume on: May 12 00:37:38 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:38 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:40 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume May 12 00:37:40 volumio-laci volumio[1102]: info: Setting Remote Device Volume: http://192.168.0.21 May 12 00:37:40 volumio-laci volumio[1102]: info: May 12 00:37:40 volumio-laci volumio[1102]: ---------------------------- Client requests Volume 13 May 12 00:37:40 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume13 May 12 00:37:40 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:40 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:40 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:40 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:40 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:40 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:40 volumio-laci volumio[1102]: info: Done setting volume on: May 12 00:37:40 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:40 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:40 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume May 12 00:37:40 volumio-laci volumio[1102]: info: Setting Remote Device Volume: http://192.168.0.21 May 12 00:37:40 volumio-laci volumio[1102]: info: May 12 00:37:40 volumio-laci volumio[1102]: ---------------------------- Client requests Volume 12 May 12 00:37:40 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume12 May 12 00:37:40 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:40 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:40 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:40 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:40 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:40 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:40 volumio-laci volumio[1102]: info: Done setting volume on: May 12 00:37:40 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:40 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:40 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume May 12 00:37:40 volumio-laci volumio[1102]: info: Setting Remote Device Volume: http://192.168.0.21 May 12 00:37:40 volumio-laci volumio[1102]: info: May 12 00:37:40 volumio-laci volumio[1102]: ---------------------------- Client requests Volume 8 May 12 00:37:40 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume8 May 12 00:37:40 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:40 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:40 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:40 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:40 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:40 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:40 volumio-laci volumio[1102]: info: Done setting volume on: May 12 00:37:40 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified May 12 00:37:40 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:40 volumio-laci volumio[1102]: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:40 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:41 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume May 12 00:37:41 volumio-laci volumio[1102]: info: Setting Remote Device Volume: http://192.168.0.21 May 12 00:37:41 volumio-laci volumio[1102]: info: May 12 00:37:41 volumio-laci volumio[1102]: ---------------------------- Client requests Volume 3 May 12 00:37:41 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume3 May 12 00:37:41 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:41 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:41 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:41 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:41 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:41 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:41 volumio-laci volumio[1102]: info: Done setting volume on: May 12 00:37:41 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified May 12 00:37:41 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:41 volumio-laci volumio[1102]: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:41 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:41 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume May 12 00:37:41 volumio-laci volumio[1102]: info: Setting Remote Device Volume: http://192.168.0.21 May 12 00:37:41 volumio-laci volumio[1102]: info: May 12 00:37:41 volumio-laci volumio[1102]: ---------------------------- Client requests Volume 1 May 12 00:37:41 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume1 May 12 00:37:41 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:41 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:41 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:41 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:41 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:41 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:41 volumio-laci volumio[1102]: info: Done setting volume on: May 12 00:37:41 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified May 12 00:37:41 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:41 volumio-laci volumio[1102]: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:41 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:42 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume May 12 00:37:42 volumio-laci volumio[1102]: info: Setting Remote Device Volume: http://192.168.0.21 May 12 00:37:42 volumio-laci volumio[1102]: info: May 12 00:37:42 volumio-laci volumio[1102]: ---------------------------- Client requests Volume 0 May 12 00:37:42 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume0 May 12 00:37:42 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:42 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:42 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:42 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:42 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:42 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:42 volumio-laci volumio[1102]: info: Done setting volume on: May 12 00:37:42 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified May 12 00:37:42 volumio-laci volumio[1102]: xcb_connection_has_error() returned true May 12 00:37:42 volumio-laci volumio[1102]: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:42 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:44 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume May 12 00:37:44 volumio-laci volumio[1102]: info: Setting Remote Device Volume: http://192.168.0.21 May 12 00:37:44 volumio-laci volumio[1102]: info: May 12 00:37:44 volumio-laci volumio[1102]: ---------------------------- Client requests Volume 1 May 12 00:37:44 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume1 May 12 00:37:44 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:44 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:44 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:44 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:44 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:44 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:44 volumio-laci volumio[1102]: info: Done setting volume on: May 12 00:37:44 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:44 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:44 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume May 12 00:37:44 volumio-laci volumio[1102]: info: Setting Remote Device Volume: http://192.168.0.21 May 12 00:37:44 volumio-laci volumio[1102]: info: May 12 00:37:44 volumio-laci volumio[1102]: ---------------------------- Client requests Volume 2 May 12 00:37:44 volumio-laci volumio[1102]: info: VolumeController::SetAlsaVolume2 May 12 00:37:44 volumio-laci volumio[1102]: info: CoreStateMachine::pushState May 12 00:37:44 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 00:37:44 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioPushState May 12 00:37:44 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output update for this device May 12 00:37:44 volumio-laci volumio[1102]: info: MRS: Pushing multiroomSync output May 12 00:37:44 volumio-laci volumio[1102]: info: CoreCommandRouter::volumioGetState May 12 00:37:44 volumio-laci volumio[1102]: info: Done setting volume on: May 12 00:37:44 volumio-laci volumio[1102]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: ALSA lib simple_none.c:1550:(simple_add1) helem (MIXER,'SoftMaster',0,3,0) appears twice or more May 12 00:37:44 volumio-laci volumio[1102]: amixer: Mixer hw:0 load error: Invalid argument May 12 00:37:48 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume May 12 00:37:48 volumio-laci volumio[1102]: error: MRS: impossible to set browserPlayback volume: device not found May 12 00:37:48 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume May 12 00:37:48 volumio-laci volumio[1102]: error: MRS: impossible to set browserPlayback volume: device not found May 12 00:37:48 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume May 12 00:37:48 volumio-laci volumio[1102]: error: MRS: impossible to set browserPlayback volume: device not found May 12 00:37:48 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume May 12 00:37:48 volumio-laci volumio[1102]: error: MRS: impossible to set browserPlayback volume: device not found May 12 00:37:48 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume May 12 00:37:48 volumio-laci volumio[1102]: error: MRS: impossible to set browserPlayback volume: device not found May 12 00:37:48 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume May 12 00:37:48 volumio-laci volumio[1102]: error: MRS: impossible to set browserPlayback volume: device not found May 12 00:37:48 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume May 12 00:37:48 volumio-laci volumio[1102]: error: MRS: impossible to set browserPlayback volume: device not found May 12 00:37:48 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume May 12 00:37:48 volumio-laci volumio[1102]: error: MRS: impossible to set browserPlayback volume: device not found May 12 00:37:54 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume May 12 00:37:54 volumio-laci volumio[1102]: error: MRS: impossible to set browserPlayback volume: device not found May 12 00:37:56 volumio-laci volumio[1102]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay May 12 00:37:56 volumio-laci volumio[1102]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom May 12 00:37:56 volumio-laci volumio[1102]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 00:37:56 volumio-laci volumio[1102]: TypeError: Cannot read property 'then' of undefined May 12 00:37:56 volumio-laci volumio[1102]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) May 12 00:37:56 volumio-laci volumio[1102]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30) May 12 00:37:56 volumio-laci volumio[1102]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1456:26) May 12 00:37:56 volumio-laci volumio[1102]: at Socket.emit (events.js:400:28) May 12 00:37:56 volumio-laci volumio[1102]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 May 12 00:37:56 volumio-laci volumio[1102]: at processTicksAndRejections (internal/process/task_queues.js:77:11) May 12 00:37:56 volumio-laci volumio[1102]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 00:37:56 volumio-laci sudo[5261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-12 00:36 May 12 00:37:56 volumio-laci sudo[5261]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 12:21:23 PM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a9588e47e4b05f1a05bf70b4acc7555c"