Feb 24 11:32:01 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 521.
Feb 24 11:32:01 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:32:01 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:32:01 volumio upmpdcli[15174]: Could not open config: /tmp/upmpdcli.conf
Feb 24 11:32:01 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 11:32:01 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Feb 24 11:32:02 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 24 11:32:08 volumio volumio[1295]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Feb 24 11:32:08 volumio volumio[1295]: info: Preparing to save Alsa Options, stopping services first
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::volumioPause
Feb 24 11:32:08 volumio volumio[1295]: info: CoreStateMachine::pause
Feb 24 11:32:08 volumio volumio[1295]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI 0 Out"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}}
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 24 11:32:08 volumio volumio[1295]: info: Found match in Cards Database: setting mixer for card HDMI 0 Out
Feb 24 11:32:08 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:08 volumio volumio[1295]: info: QobuzConnect: setDeactiveState(): relinquishing Volumio State
Feb 24 11:32:08 volumio volumio[1295]: verbose: UNSET VOLATILE: Service: qobuzconnect
Feb 24 11:32:08 volumio volumio[1295]: info: QobuzConnect: onUnsetVolatile() called, relinquishing Volumio State to another service
Feb 24 11:32:08 volumio volumio[1295]: info: QobuzConnect: Received stop
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:08 volumio qobuz-connect[14714]: 20260224 11:32:08.837 [14714.14714] INFO MediaEngine: [0x1862fc0]: Stopping playback, keeping tracks
Feb 24 11:32:08 volumio volumio[1295]: info: Device 0 does not have any Mixer Control Available
Feb 24 11:32:08 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:08 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Feb 24 11:32:08 volumio volumio[1295]: info: Updating Volume Controller Parameters: Device: 0 Name: HDMI 0 Out Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Feb 24 11:32:08 volumio volumio[1295]: info: Disabling external Volume Control
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 24 11:32:08 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:08 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:08 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:08 volumio volumio[1295]: info: Preparing to generate the ALSA configuration file
Feb 24 11:32:08 volumio sudo[15217]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 24 11:32:08 volumio sudo[15217]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:08 volumio sudo[15225]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 24 11:32:08 volumio sudo[15225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:08 volumio sudo[15217]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 24 11:32:08 volumio sudo[15230]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 24 11:32:08 volumio sudo[15225]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:08 volumio sudo[15230]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:08 volumio sudo[15234]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 24 11:32:08 volumio sudo[15234]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 24 11:32:08 volumio qobuz-connect[14714]: 20260224 11:32:08.942 [14714.14714] INFO ContentFetcher: [0x1a50398]: Canceling download
Feb 24 11:32:08 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service...
Feb 24 11:32:08 volumio qobuz-connect[14714]: 20260224 11:32:08.945 [14714.14714] INFO CloudClient: [0x1863598]: Disconnecting from the cloud
Feb 24 11:32:08 volumio qobuz-connect[14714]: 20260224 11:32:08.945 [14714.14714] INFO CloudClient: [0x1863598]: Connection closed
Feb 24 11:32:08 volumio volumio[1295]: info: Asound.conf file written
Feb 24 11:32:08 volumio sudo[15239]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Feb 24 11:32:08 volumio sudo[15239]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:08 volumio sudo[15239]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:08 volumio qobuz-connect[14714]: 20260224 11:32:08.964 [14714.14714] INFO SampleApp: Stopping Local configuration server
Feb 24 11:32:08 volumio volumio[1295]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2
Feb 24 11:32:08 volumio volumio[1295]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2
Feb 24 11:32:08 volumio volumio[1295]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2
Feb 24 11:32:08 volumio volumio[1295]: info: Output device has changed, restarting MPD
Feb 24 11:32:08 volumio volumio[1295]: info: Output device has changed, restarting Shairport Sync
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:08 volumio sudo[15245]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 24 11:32:08 volumio sudo[15245]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:08 volumio sudo[15245]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:08 volumio sudo[15248]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 24 11:32:08 volumio sudo[15248]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:08 volumio volumio[1295]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 24 11:32:08 volumio volumio[1295]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 24 11:32:08 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:09 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:09 volumio volumio[1295]: info: Output device has changed, restarting MPD
Feb 24 11:32:09 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Feb 24 11:32:09 volumio volumio[1295]: info: Output device has changed, restarting Shairport Sync
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:09 volumio sudo[15259]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 24 11:32:09 volumio sudo[15257]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 24 11:32:09 volumio sudo[15257]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio sudo[15259]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio sudo[15257]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio volumio[1295]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 24 11:32:09 volumio volumio[1295]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:09 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:09 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 24 11:32:09 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 24 11:32:09 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 24 11:32:09 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 24 11:32:09 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 24 11:32:09 volumio sudo[15275]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 24 11:32:09 volumio sudo[15275]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio volumio[1295]: info: MPD Permissions set
Feb 24 11:32:09 volumio volumio[1295]: info: MPD Permissions set
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 24 11:32:09 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 24 11:32:09 volumio sudo[15284]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 24 11:32:09 volumio sudo[15284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio sudo[15275]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio sudo[15297]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 24 11:32:09 volumio sudo[15297]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: Starting Shairport Sync
Feb 24 11:32:09 volumio sudo[15284]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio volumio[1295]: info: Starting Shairport Sync
Feb 24 11:32:09 volumio sudo[15301]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 24 11:32:09 volumio sudo[15302]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 24 11:32:09 volumio volumio[1295]: info: Preparing to generate the ALSA configuration file
Feb 24 11:32:09 volumio sudo[15301]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio sudo[15302]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio volumio[1295]: info: Asound.conf file unchanged, so no further update is needed
Feb 24 11:32:09 volumio volumio[1295]: info: Output device has changed, restarting MPD
Feb 24 11:32:09 volumio sudo[15305]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 24 11:32:09 volumio sudo[15305]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio sudo[15287]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 24 11:32:09 volumio sudo[15287]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 24 11:32:09 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 24 11:32:09 volumio volumio[1295]: info: Output device has changed, restarting Shairport Sync
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:09 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 24 11:32:09 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 24 11:32:09 volumio systemd[1]: shairport-sync.service: Consumed 1.819s CPU time.
Feb 24 11:32:09 volumio sudo[15287]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio sudo[15309]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 24 11:32:09 volumio sudo[15309]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio sudo[15309]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio sudo[15311]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 24 11:32:09 volumio sudo[15311]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio volumio[1295]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 24 11:32:09 volumio volumio[1295]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:09 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:09 volumio volumio[1295]: info: Preparing to generate the ALSA configuration file
Feb 24 11:32:09 volumio sudo[15327]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 24 11:32:09 volumio sudo[15327]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio volumio[1295]: info: MPD Permissions set
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 24 11:32:09 volumio sudo[15302]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: Shairport-Sync Started
Feb 24 11:32:09 volumio volumio[1295]: info: Asound.conf file unchanged, so no further update is needed
Feb 24 11:32:09 volumio volumio[1295]: info: Output device has changed, restarting MPD
Feb 24 11:32:09 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 24 11:32:09 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 24 11:32:09 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 24 11:32:09 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 24 11:32:09 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 24 11:32:09 volumio volumio[1295]: info: Output device has changed, restarting Shairport Sync
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:09 volumio sudo[15349]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 24 11:32:09 volumio sudo[15349]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 24 11:32:09 volumio sudo[15349]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio sudo[15327]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 24 11:32:09 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 24 11:32:09 volumio sudo[15353]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 24 11:32:09 volumio sudo[15353]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio sudo[15356]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 24 11:32:09 volumio sudo[15356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio volumio[1295]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 24 11:32:09 volumio volumio[1295]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 24 11:32:09 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:09 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:09 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 24 11:32:09 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 24 11:32:09 volumio sudo[15305]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio volumio[1295]: info: MPD Permissions set
Feb 24 11:32:09 volumio volumio[1295]: info: Shairport-Sync Started
Feb 24 11:32:09 volumio volumio[1295]: info: Starting Shairport Sync
Feb 24 11:32:09 volumio sudo[15385]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 24 11:32:09 volumio sudo[15385]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio sudo[15388]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 24 11:32:09 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 24 11:32:09 volumio sudo[15388]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 24 11:32:09 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 24 11:32:09 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:09 volumio volumio[1295]: info: Starting Shairport Sync
Feb 24 11:32:09 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 24 11:32:09 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 24 11:32:09 volumio sudo[15398]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 24 11:32:09 volumio sudo[15398]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio sudo[15385]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 24 11:32:09 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 24 11:32:09 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 24 11:32:09 volumio sudo[15401]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 24 11:32:09 volumio sudo[15401]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:09 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 24 11:32:09 volumio sudo[15398]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio sudo[15388]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio volumio[1295]: info: Shairport-Sync Started
Feb 24 11:32:09 volumio sudo[15399]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 24 11:32:09 volumio sudo[15399]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 24 11:32:09 volumio volumio[1295]: info: Shairport-Sync Started
Feb 24 11:32:09 volumio sudo[15399]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio qobuz-connect[14714]: 20260224 11:32:09.813 [14714.14714] INFO SampleApp: shat down connection on UNIX socket
Feb 24 11:32:09 volumio volumio[1295]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Feb 24 11:32:09 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:09 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:09 volumio systemd[1]: qobuz-connect.service: Deactivated successfully.
Feb 24 11:32:09 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service.
Feb 24 11:32:09 volumio systemd[1]: qobuz-connect.service: Consumed 4.319s CPU time.
Feb 24 11:32:09 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service.
Feb 24 11:32:09 volumio sudo[15356]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio sudo[15234]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio sudo[15297]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio sudo[15301]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio sudo[15401]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio sudo[15230]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:09 volumio volumio[1295]: info: Executing endpoint qc_getconfig
Feb 24 11:32:09 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Feb 24 11:32:09 volumio qobuz-connect[15420]: 20260224 11:32:09.890 [15420.15420] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Feb 24 11:32:09 volumio qobuz-connect[15420]: 20260224 11:32:09.893 [15420.15420] INFO VolumeManager: [0xf47428]: Setting new playback volume: 75
Feb 24 11:32:09 volumio qobuz-connect[15420]: 20260224 11:32:09.893 [15420.15420] INFO VolumeManager: [0xf47428]: Setting new mute state: 0
Feb 24 11:32:09 volumio qobuz-connect[15420]: 20260224 11:32:09.894 [15420.15420] INFO QobuzConnect: [0xf47df8]: Client initialized!
Feb 24 11:32:09 volumio qobuz-connect[15420]: 20260224 11:32:09.894 [15420.15420] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp
Feb 24 11:32:09 volumio volumio[1295]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Feb 24 11:32:09 volumio volumio[1295]: info: QobuzConnect: QOBUZ Connect daemon connected
Feb 24 11:32:09 volumio qobuz-connect[15420]: 20260224 11:32:09.902 [15420.15420] INFO LocalConfigManager: [0xf46d08]: Starting Local Configuration server
Feb 24 11:32:09 volumio qobuz-connect[15420]: 20260224 11:32:09.902 [15420.15420] INFO SampleApp: Starting Local configuration server
Feb 24 11:32:09 volumio qobuz-connect[15420]: 20260224 11:32:09.902 [15420.15420] INFO SampleApp: Connected to UNIX socket client 0xf31818
Feb 24 11:32:10 volumio qobuz-connect[15420]: 20260224 11:32:10.040 [15420.15420] INFO SampleApp: Playback volume changed: 75
Feb 24 11:32:10 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:10 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:10 volumio mpd[15418]: 2026-02-24T11:32:10 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 24 11:32:10 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Feb 24 11:32:10 volumio sudo[15353]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:10 volumio sudo[15259]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:10 volumio sudo[15248]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:10 volumio sudo[15311]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:10 volumio volumio[1295]: error: MPD error: The expression evaluated to a falsy value:
Feb 24 11:32:10 volumio volumio[1295]: assert.ok(self.idling)
Feb 24 11:32:10 volumio volumio[1295]: error: The expression evaluated to a falsy value:
Feb 24 11:32:10 volumio volumio[1295]: assert.ok(self.idling)
Feb 24 11:32:10 volumio volumio[1295]: error: updateQueue error: null
Feb 24 11:32:10 volumio volumio[1295]: error: MPD error: The expression evaluated to a falsy value:
Feb 24 11:32:10 volumio volumio[1295]: assert.ok(self.idling)
Feb 24 11:32:10 volumio volumio[1295]: error: The expression evaluated to a falsy value:
Feb 24 11:32:10 volumio volumio[1295]: assert.ok(self.idling)
Feb 24 11:32:10 volumio volumio[1295]: error: updateQueue error: null
Feb 24 11:32:12 volumio volumio[1295]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Feb 24 11:32:12 volumio volumio[1295]: info: CoreStateMachine::getcurrentVolume
Feb 24 11:32:12 volumio volumio[1295]: info: CoreCommandRouter::volumioRetrievevolume
Feb 24 11:32:12 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:12 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:12 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:12 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:12 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:16 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 522.
Feb 24 11:32:16 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:32:16 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:32:16 volumio upmpdcli[15443]: Could not open config: /tmp/upmpdcli.conf
Feb 24 11:32:16 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 11:32:16 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 24 11:32:18 volumio volumio[1295]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Feb 24 11:32:18 volumio volumio[1295]: info: Preparing to save Alsa Options, stopping services first
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:18 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::volumioPause
Feb 24 11:32:18 volumio volumio[1295]: info: CoreStateMachine::pause
Feb 24 11:32:18 volumio volumio[1295]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"UNISON USB DAC 2"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}}
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 24 11:32:18 volumio volumio[1295]: info: Device 5 does not have any Mixer Control Available
Feb 24 11:32:18 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:18 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Feb 24 11:32:18 volumio volumio[1295]: info: Updating Volume Controller Parameters: Device: 5 Name: UNISON USB DAC 2 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Feb 24 11:32:18 volumio volumio[1295]: info: Disabling external Volume Control
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 24 11:32:18 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:18 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:18 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:18 volumio volumio[1295]: info: Preparing to generate the ALSA configuration file
Feb 24 11:32:18 volumio sudo[15461]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 24 11:32:18 volumio sudo[15461]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 24 11:32:18 volumio sudo[15461]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio sudo[15467]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 24 11:32:18 volumio sudo[15467]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 24 11:32:18 volumio volumio[1295]: info: Asound.conf file written
Feb 24 11:32:18 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service...
Feb 24 11:32:18 volumio qobuz-connect[15420]: 20260224 11:32:18.328 [15420.15420] INFO SampleApp: Stopping Local configuration server
Feb 24 11:32:18 volumio sudo[15473]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Feb 24 11:32:18 volumio sudo[15473]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio sudo[15473]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio volumio[1295]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2
Feb 24 11:32:18 volumio volumio[1295]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2
Feb 24 11:32:18 volumio volumio[1295]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2
Feb 24 11:32:18 volumio volumio[1295]: info: Output device has changed, restarting MPD
Feb 24 11:32:18 volumio volumio[1295]: info: Output device has changed, restarting Shairport Sync
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:18 volumio sudo[15479]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 24 11:32:18 volumio sudo[15479]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio sudo[15479]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio sudo[15484]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 24 11:32:18 volumio sudo[15484]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio volumio[1295]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 24 11:32:18 volumio volumio[1295]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:18 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:18 volumio volumio[1295]: info: Output device has changed, restarting MPD
Feb 24 11:32:18 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Feb 24 11:32:18 volumio volumio[1295]: info: Output device has changed, restarting Shairport Sync
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:18 volumio sudo[15491]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 24 11:32:18 volumio sudo[15491]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio sudo[15493]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 24 11:32:18 volumio sudo[15493]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio sudo[15491]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio volumio[1295]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 24 11:32:18 volumio volumio[1295]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:18 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:18 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 24 11:32:18 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 24 11:32:18 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 24 11:32:18 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 24 11:32:18 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 24 11:32:18 volumio sudo[15508]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 24 11:32:18 volumio sudo[15508]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio volumio[1295]: info: MPD Permissions set
Feb 24 11:32:18 volumio volumio[1295]: info: MPD Permissions set
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio sudo[15514]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 24 11:32:18 volumio sudo[15514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio sudo[15514]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio sudo[15508]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: Starting Shairport Sync
Feb 24 11:32:18 volumio sudo[15528]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 24 11:32:18 volumio sudo[15528]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio sudo[15529]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 24 11:32:18 volumio sudo[15529]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio volumio[1295]: info: Starting Shairport Sync
Feb 24 11:32:18 volumio volumio[1295]: info: Preparing to generate the ALSA configuration file
Feb 24 11:32:18 volumio sudo[15534]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 24 11:32:18 volumio sudo[15534]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio sudo[15536]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 24 11:32:18 volumio sudo[15536]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio volumio[1295]: info: Asound.conf file unchanged, so no further update is needed
Feb 24 11:32:18 volumio volumio[1295]: info: Output device has changed, restarting MPD
Feb 24 11:32:18 volumio sudo[15517]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 24 11:32:18 volumio sudo[15517]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 24 11:32:18 volumio sudo[15517]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio volumio[1295]: info: Output device has changed, restarting Shairport Sync
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:18 volumio sudo[15540]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 24 11:32:18 volumio sudo[15540]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio sudo[15540]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio sudo[15542]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 24 11:32:18 volumio sudo[15542]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio volumio[1295]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 24 11:32:18 volumio volumio[1295]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:18 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:18 volumio volumio[1295]: info: Preparing to generate the ALSA configuration file
Feb 24 11:32:18 volumio volumio[1295]: info: MPD Permissions set
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 24 11:32:18 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 24 11:32:18 volumio systemd[1]: shairport-sync.service: Consumed 1.528s CPU time.
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio sudo[15557]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 24 11:32:18 volumio sudo[15557]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio volumio[1295]: info: Asound.conf file unchanged, so no further update is needed
Feb 24 11:32:18 volumio volumio[1295]: info: Output device has changed, restarting MPD
Feb 24 11:32:18 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 24 11:32:18 volumio sudo[15534]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio sudo[15536]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 24 11:32:18 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 24 11:32:18 volumio volumio[1295]: info: Output device has changed, restarting Shairport Sync
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:18 volumio sudo[15567]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 24 11:32:18 volumio sudo[15567]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio sudo[15569]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 24 11:32:18 volumio sudo[15569]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio sudo[15567]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 24 11:32:18 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 24 11:32:18 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 24 11:32:18 volumio volumio[1295]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 24 11:32:18 volumio volumio[1295]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:18 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:18 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 24 11:32:18 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 24 11:32:18 volumio volumio[1295]: info: MPD Permissions set
Feb 24 11:32:18 volumio volumio[1295]: info: Shairport-Sync Started
Feb 24 11:32:18 volumio volumio[1295]: info: Shairport-Sync Started
Feb 24 11:32:18 volumio volumio[1295]: info: Starting Shairport Sync
Feb 24 11:32:18 volumio sudo[15601]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 24 11:32:18 volumio sudo[15601]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio sudo[15557]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 24 11:32:18 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 24 11:32:18 volumio sudo[15604]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 24 11:32:18 volumio sudo[15604]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 24 11:32:18 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 24 11:32:18 volumio sudo[15611]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 24 11:32:18 volumio sudo[15611]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio volumio[1295]: info: Starting Shairport Sync
Feb 24 11:32:18 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 24 11:32:18 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 24 11:32:18 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 24 11:32:18 volumio sudo[15615]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 24 11:32:18 volumio sudo[15615]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 24 11:32:18 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 24 11:32:18 volumio sudo[15601]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio sudo[15618]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 24 11:32:18 volumio sudo[15618]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 24 11:32:18 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 24 11:32:18 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 24 11:32:18 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 24 11:32:18 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 24 11:32:18 volumio sudo[15604]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio sudo[15615]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:18 volumio volumio[1295]: info: Shairport-Sync Started
Feb 24 11:32:18 volumio volumio[1295]: info: Shairport-Sync Started
Feb 24 11:32:18 volumio sudo[15617]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 24 11:32:18 volumio sudo[15617]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 24 11:32:18 volumio sudo[15617]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:19 volumio mpd[15624]: 2026-02-24T11:32:19 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 24 11:32:19 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Feb 24 11:32:19 volumio sudo[15542]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:19 volumio sudo[15493]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:19 volumio sudo[15484]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:19 volumio sudo[15569]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:19 volumio volumio[1295]: error: MPD error: The expression evaluated to a falsy value:
Feb 24 11:32:19 volumio volumio[1295]: assert.ok(self.idling)
Feb 24 11:32:19 volumio volumio[1295]: error: The expression evaluated to a falsy value:
Feb 24 11:32:19 volumio volumio[1295]: assert.ok(self.idling)
Feb 24 11:32:19 volumio volumio[1295]: error: MPD error: The expression evaluated to a falsy value:
Feb 24 11:32:19 volumio volumio[1295]: assert.ok(self.idling)
Feb 24 11:32:19 volumio volumio[1295]: error: The expression evaluated to a falsy value:
Feb 24 11:32:19 volumio volumio[1295]: assert.ok(self.idling)
Feb 24 11:32:19 volumio volumio[1295]: error: MPD error: The expression evaluated to a falsy value:
Feb 24 11:32:19 volumio volumio[1295]: assert.ok(self.idling)
Feb 24 11:32:19 volumio volumio[1295]: error: The expression evaluated to a falsy value:
Feb 24 11:32:19 volumio volumio[1295]: assert.ok(self.idling)
Feb 24 11:32:19 volumio volumio[1295]: error: updateQueue error: null
Feb 24 11:32:19 volumio qobuz-connect[15420]: 20260224 11:32:19.921 [15420.15420] INFO SampleApp: shat down connection on UNIX socket
Feb 24 11:32:19 volumio volumio[1295]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Feb 24 11:32:19 volumio volumio[1295]: info: QobuzConnect: setDeactiveState invoked
Feb 24 11:32:19 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:19 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:19 volumio systemd[1]: qobuz-connect.service: Deactivated successfully.
Feb 24 11:32:19 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service.
Feb 24 11:32:19 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service.
Feb 24 11:32:19 volumio sudo[15529]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:19 volumio sudo[15528]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:19 volumio sudo[15611]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:19 volumio sudo[15467]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:19 volumio sudo[15618]: pam_unix(sudo:session): session closed for user root
Feb 24 11:32:19 volumio volumio[1295]: info: Executing endpoint qc_getconfig
Feb 24 11:32:19 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Feb 24 11:32:19 volumio qobuz-connect[15639]: 20260224 11:32:19.977 [15639.15639] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Feb 24 11:32:19 volumio qobuz-connect[15639]: 20260224 11:32:19.979 [15639.15639] INFO VolumeManager: [0x1e4d428]: Setting new playback volume: 75
Feb 24 11:32:19 volumio qobuz-connect[15639]: 20260224 11:32:19.979 [15639.15639] INFO VolumeManager: [0x1e4d428]: Setting new mute state: 0
Feb 24 11:32:19 volumio qobuz-connect[15639]: 20260224 11:32:19.979 [15639.15639] INFO QobuzConnect: [0x1e4ddf8]: Client initialized!
Feb 24 11:32:19 volumio qobuz-connect[15639]: 20260224 11:32:19.979 [15639.15639] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp
Feb 24 11:32:19 volumio volumio[1295]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Feb 24 11:32:19 volumio volumio[1295]: info: QobuzConnect: QOBUZ Connect daemon connected
Feb 24 11:32:19 volumio qobuz-connect[15639]: 20260224 11:32:19.986 [15639.15639] INFO LocalConfigManager: [0x1e4cd08]: Starting Local Configuration server
Feb 24 11:32:19 volumio qobuz-connect[15639]: 20260224 11:32:19.986 [15639.15639] INFO SampleApp: Starting Local configuration server
Feb 24 11:32:19 volumio qobuz-connect[15639]: 20260224 11:32:19.986 [15639.15639] INFO SampleApp: Connected to UNIX socket client 0x1e37818
Feb 24 11:32:20 volumio qobuz-connect[15639]: 20260224 11:32:20.128 [15639.15639] INFO SampleApp: Playback volume changed: 75
Feb 24 11:32:20 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:20 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:22 volumio volumio[1295]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Feb 24 11:32:22 volumio volumio[1295]: info: CoreStateMachine::getcurrentVolume
Feb 24 11:32:22 volumio volumio[1295]: info: CoreCommandRouter::volumioRetrievevolume
Feb 24 11:32:22 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:22 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:22 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:22 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:22 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:31 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 523.
Feb 24 11:32:31 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:32:31 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:32:31 volumio upmpdcli[15661]: Could not open config: /tmp/upmpdcli.conf
Feb 24 11:32:31 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 11:32:31 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 24 11:32:36 volumio qobuz-connect[15639]: 20260224 11:32:36.960 [15639.15643] INFO SampleApp: API endpoint invoked: get-connect-info
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.128 [15639.15643] INFO SampleApp: API endpoint invoked: connect-to-qconnect
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.128 [15639.15639] INFO EndpointManager: [0x1e4c938]: Updating API endpoint
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.128 [15639.15639] INFO EndpointManager: [0x1e4c938]: Updating QConnect endpoint
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.128 [15639.15639] INFO ActiveStateManager: [0x1e4b950]: Setting new active state: active
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.128 [15639.15639] INFO PlaybackSessionManager: [0x1e4cd28]: Starting playback session maintenance
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.128 [15639.15639] INFO HttpDownloader: [0x1e4cf18]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.128 [15639.15639] INFO CloudClient: [0x1e4d598]: Connecting to the cloud
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.129 [15639.15639] INFO SampleApp: Renderer is now active
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.238 [15639.15639] INFO CloudClient: [0x1e4d598]: Connection established
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.238 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Authenticate message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.238 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Subscribe message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.238 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending JoinSession message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.238 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending VolumeChanged message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.238 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending VolumeMuted message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.238 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending MaxAudioQualityChanged message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.238 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Payload message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Received SetActive message: active
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Received SetState message:
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Playing state: Playing
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Playback position: 0
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Queue version: 4.1
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Current track: TID: 5250691, QID: 7, Context UUID: 443881b4-f425-484f-9afa-f3f7a5601a78
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Next track: TID: 4294967295, QID: -1, Context UUID:
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO MediaEngine: [0x1e4cfc0]: Stopping playback, clearing tracks
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO MediaEngine: [0x1e4cfc0]: Initiating playback
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Received SetLoopMode message: Off
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO PlaybackControlsManager: [0x1e4d398]: Setting new loop mode: Off
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO MediaEngine: [0x1e4cfc0]: Setting current track: 5250691, initial offset: 0ms
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO AudioStreamManager: [0x1e4d0a8]: Clearing all streams
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO AudioStreamManager: [0x1e4d0a8]: New stream: 1
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO HttpDownloader: [0x1e87850]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=f211d05fe289afb5939f95dd0822d431&request_ts=1771929157&track_id=5250691
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO HttpDownloader: [0x1e887e0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=5250691
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO AudioStreamManager: [0x1e4d0a8]: [Stream 1]: Running audio stream
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Received SetShuffleMode message: disabled
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO PlaybackControlsManager: [0x1e4d398]: Setting new shuffle mode: disabled
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO MediaEngine: [0x1e4cfc0]: Setting next track: NONE
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.274 [15639.15639] INFO MediaEngine: [0x1e4cfc0]: Waiting for current stream to start before starting audio renderer
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.310 [15639.15639] INFO PlaybackSessionManager: [0x1e4cd28]: Playback session has been refreshed
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.310 [15639.15639] INFO HttpDownloader: [0x1e500d8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=361454503a5666ff3dbd044f4a99631d&request_ts=1771929157&track_id=5250691
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.325 [15639.15639] INFO AudioStreamManager: [0x1e4d0a8]: [Stream 1]: Metadata became available:
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.325 [15639.15639] INFO AudioStreamManager: [0x1e4d0a8]: Title: The Overload
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.325 [15639.15639] INFO AudioStreamManager: [0x1e4d0a8]: Artist: Talking Heads
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.325 [15639.15639] INFO AudioStreamManager: [0x1e4d0a8]: Album: Remain In Light
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.325 [15639.15639] INFO AudioStreamManager: [0x1e4d0a8]: Album art URL: https://static.qobuz.com/images/covers/36/09/0603497940936_600.jpg
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.379 [15639.15639] INFO AudioStreamManager: [0x1e4d0a8]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1428089&eid=5250691&fmt=7&profile=raw&app_id=174516466&cid=1304056&etsp=1771932757&hmac=PRF6r7B4tqzQxpAf5Zjnkuur2NA
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.470 [15639.15639] INFO AudioStreamManager: [0x1e4d0a8]: [Stream 1]: stream information have been fetched
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.470 [15639.15639] INFO UrlAudioSource: [0x1e535c0]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=1428089&eid=5250691&fmt=7&profile=raw&app_id=174516466&cid=1304056&etsp=1771932757&hmac=PRF6r7B4tqzQxpAf5Zjnkuur2NA
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.470 [15639.15639] INFO ContentFetcher: [0x1f311d8]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=1428089&eid=5250691&fmt=7&profile=raw&app_id=174516466&cid=1304056&etsp=1771932757&hmac=PRF6r7B4tqzQxpAf5Zjnkuur2NA, offset: 0
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.470 [15639.15639] INFO AudioRenderer: [0x1e4d1e0]: Starting audio renderer, initial playback state: Playing
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.470 [15639.15639] INFO SampleApp: [Stream 1]: New audio stream (starting from 0ms)
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.470 [15639.15639] INFO SampleApp: [Stream 1]: Stream metadata became available:
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.470 [15639.15639] INFO SampleApp: Title: The Overload
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.470 [15639.15639] INFO SampleApp: Artist: Talking Heads
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.470 [15639.15639] INFO SampleApp: Album: Remain In Light
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.470 [15639.15639] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/36/09/0603497940936_600.jpg
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:37 volumio volumio[1295]: info: QobuzConnect: setActiveState()
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:37 volumio volumio[1295]: info: QobuzConnect: Set Qobuz connect default volume to 100
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:37 volumio volumio[1295]: info: QobuzConnect: Stopping currently active service
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioStop
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::stop
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::updateTrackBlock
Feb 24 11:32:37 volumio volumio[1295]: info: CorePlayQueue::getTrackBlock
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::stPlaybackTimer
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:37 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.472 [15639.15639] INFO VolumeManager: [0x1e4d428]: Setting new playback volume: 100
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::serviceStop
Feb 24 11:32:37 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:37 volumio volumio[1295]: info: ControllerMpd::stop
Feb 24 11:32:37 volumio volumio[1295]: verbose: ControllerMpd::sendMpdCommand stop
Feb 24 11:32:37 volumio volumio[1295]: info: sendMpdCommand stop took 2 milliseconds
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::servicePushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:37 volumio volumio[1295]: verbose: STATE SERVICE {"status":"stop","service":"qobuzconnect","title":"Listening Wind","artist":"Talking Heads","album":"Remain In Light","albumart":"https://static.qobuz.com/images/covers/36/09/0603497940936_600.jpg","uri":"","icon":"fa fa-spinner","trackType":"qobuz","codec":"","seek":0,"duration":291,"samplerate":"96 kHz","bitdepth":"24 bit","bitrate":"","channels":2,"random":false,"stream":false,"repeatMode":"all"}
Feb 24 11:32:37 volumio volumio[1295]: verbose: CURRENT POSITION 0
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::syncState stateService stop
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::syncState currentStatus stop
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: No code
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect
Feb 24 11:32:37 volumio volumio[1295]: info: QobuzConnect: setActiveState() completed, send playback confirmation
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.477 [15639.15639] INFO SampleApp: Initiating playback, initial state: Playing
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.485 [15639.15639] INFO SampleApp: Playback state changed: Playing
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.485 [15639.15639] INFO StreamingEventReporter: [0x1e4db18]: Reporting streaming started event
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.485 [15639.15639] INFO HttpDownloader: [0x1e4db70]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.485 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Need to send state update
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.485 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending StateUpdated message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.486 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Payload message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.486 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending FileAudioQualityChanged message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.486 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Payload message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.486 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending DeviceAudioQualityChanged message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.486 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Payload message
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::servicePushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CorePlayQueue::getTrack 0
Feb 24 11:32:37 volumio volumio[1295]: verbose: STATE SERVICE {"status":"stop","service":"qobuzconnect","title":"Listening Wind","artist":"Talking Heads","album":"Remain In Light","albumart":"https://static.qobuz.com/images/covers/36/09/0603497940936_600.jpg","uri":"","icon":"fa fa-spinner","trackType":"qobuz","codec":"","seek":0,"duration":291,"samplerate":"96 kHz","bitdepth":"24 bit","bitrate":"","channels":2,"random":false,"stream":false,"repeatMode":"all"}
Feb 24 11:32:37 volumio volumio[1295]: verbose: CURRENT POSITION 0
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::syncState stateService stop
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::syncState currentStatus stop
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: No code
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::servicePushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::servicePushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::servicePushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.622 [15639.15639] INFO SampleApp: Playback volume changed: 100
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.622 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Volume changed: 100
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.622 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending VolumeChanged message
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.622 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Payload message
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio volumio[1295]: info: QobuzConnect: Volume received from daemon: 100
Feb 24 11:32:37 volumio volumio[1295]: info: VolumeController::SetAlsaVolume100
Feb 24 11:32:37 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.705 [15639.15639] INFO UrlAudioSource: [0x1e535c0]: Content info extracted
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.705 [15639.15639] INFO UrlAudioSource: [0x1e535c0]: Size: 156457383
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.705 [15639.15679] INFO AudioDecoder: [0x20d3360]: Stream info:
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.706 [15639.15679] INFO AudioDecoder: [0x20d3360]: Total samples: 42806400
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.706 [15639.15679] INFO AudioDecoder: [0x20d3360]: Sample rate: 96000
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.706 [15639.15679] INFO AudioDecoder: [0x20d3360]: Channel count: 2
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.706 [15639.15679] INFO AudioDecoder: [0x20d3360]: Bits per sample: 24
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.706 [15639.15679] INFO AudioDecoder: [0x20d3360]: Duration: 445900
Feb 24 11:32:37 volumio qobuz-connect[15639]: 20260224 11:32:37.706 [15639.15639] INFO UrlAudioSource: [0x1e535c0]: Audio properties have changed
Feb 24 11:32:47 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 524.
Feb 24 11:32:47 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:32:47 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:32:47 volumio upmpdcli[15695]: Could not open config: /tmp/upmpdcli.conf
Feb 24 11:32:47 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 11:32:47 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 24 11:32:47 volumio qobuz-connect[15639]: 20260224 11:32:47.485 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Need to send state update
Feb 24 11:32:47 volumio qobuz-connect[15639]: 20260224 11:32:47.485 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending StateUpdated message
Feb 24 11:32:47 volumio qobuz-connect[15639]: 20260224 11:32:47.485 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Payload message
Feb 24 11:32:47 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:47 volumio volumio[1295]: info: CoreCommandRouter::servicePushState
Feb 24 11:32:47 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:47 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 11:32:47 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:47 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:48 volumio volumio[1295]: verbose: New Socket.io Connection to 192.168.1.9 from 192.168.1.70 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.3 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 6
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 24 11:32:48 volumio volumio[1295]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Feb 24 11:32:48 volumio volumio[1295]: info: Received Get System Info
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 24 11:32:48 volumio volumio[1295]: info: Discovery: Getting this device information
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:48 volumio volumio[1295]: info: Listing playlists
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::volumioGetQueue
Feb 24 11:32:48 volumio volumio[1295]: info: CoreStateMachine::getQueue
Feb 24 11:32:48 volumio volumio[1295]: info: CorePlayQueue::getQueue
Feb 24 11:32:48 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 24 11:32:57 volumio qobuz-connect[15639]: 20260224 11:32:57.486 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Need to send state update
Feb 24 11:32:57 volumio qobuz-connect[15639]: 20260224 11:32:57.486 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending StateUpdated message
Feb 24 11:32:57 volumio qobuz-connect[15639]: 20260224 11:32:57.486 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Payload message
Feb 24 11:32:57 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:32:57 volumio volumio[1295]: info: CoreCommandRouter::servicePushState
Feb 24 11:32:57 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:32:57 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 11:32:57 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:32:57 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:33:02 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 525.
Feb 24 11:33:02 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:33:02 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:33:02 volumio upmpdcli[15710]: Could not open config: /tmp/upmpdcli.conf
Feb 24 11:33:02 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 11:33:02 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 24 11:33:05 volumio volumio[1295]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 24 11:33:05 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Feb 24 11:33:05 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Feb 24 11:33:05 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Feb 24 11:33:05 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Feb 24 11:33:05 volumio volumio[1295]: info: Received Get System Version
Feb 24 11:33:05 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 24 11:33:07 volumio qobuz-connect[15639]: 20260224 11:33:07.487 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Need to send state update
Feb 24 11:33:07 volumio qobuz-connect[15639]: 20260224 11:33:07.487 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending StateUpdated message
Feb 24 11:33:07 volumio qobuz-connect[15639]: 20260224 11:33:07.487 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Payload message
Feb 24 11:33:07 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:33:07 volumio volumio[1295]: info: CoreCommandRouter::servicePushState
Feb 24 11:33:07 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:33:07 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 11:33:07 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:33:07 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:33:12 volumio volumio-remote-updater[960]: Test mode disabled
Feb 24 11:33:12 volumio volumio-remote-updater[960]: Alpha mode disabled
Feb 24 11:33:12 volumio volumio-remote-updater[960]: Alpha legacy test mode disabled
Feb 24 11:33:12 volumio volumio[1295]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Feb 24 11:33:12 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Feb 24 11:33:14 volumio volumio[1295]: info: CoreCommandRouter::Close All Modals sent
Feb 24 11:33:17 volumio qobuz-connect[15639]: 20260224 11:33:17.486 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Need to send state update
Feb 24 11:33:17 volumio qobuz-connect[15639]: 20260224 11:33:17.486 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending StateUpdated message
Feb 24 11:33:17 volumio qobuz-connect[15639]: 20260224 11:33:17.486 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Payload message
Feb 24 11:33:17 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:33:17 volumio volumio[1295]: info: CoreCommandRouter::servicePushState
Feb 24 11:33:17 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:33:17 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 11:33:17 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:33:17 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:33:17 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 526.
Feb 24 11:33:17 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:33:17 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:33:17 volumio upmpdcli[15760]: Could not open config: /tmp/upmpdcli.conf
Feb 24 11:33:17 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 11:33:17 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 24 11:33:27 volumio qobuz-connect[15639]: 20260224 11:33:27.487 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Need to send state update
Feb 24 11:33:27 volumio qobuz-connect[15639]: 20260224 11:33:27.487 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending StateUpdated message
Feb 24 11:33:27 volumio qobuz-connect[15639]: 20260224 11:33:27.487 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Payload message
Feb 24 11:33:27 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:33:27 volumio volumio[1295]: info: CoreCommandRouter::servicePushState
Feb 24 11:33:27 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:33:27 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 11:33:27 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:33:27 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:33:29 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 24 11:33:29 volumio volumio[1295]: info: CURURI: artists://
Feb 24 11:33:29 volumio volumio[1295]: info: Preload queue cleared
Feb 24 11:33:32 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 527.
Feb 24 11:33:32 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:33:32 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:33:32 volumio upmpdcli[15776]: Could not open config: /tmp/upmpdcli.conf
Feb 24 11:33:32 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 11:33:32 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 24 11:33:37 volumio qobuz-connect[15639]: 20260224 11:33:37.487 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Need to send state update
Feb 24 11:33:37 volumio qobuz-connect[15639]: 20260224 11:33:37.487 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending StateUpdated message
Feb 24 11:33:37 volumio qobuz-connect[15639]: 20260224 11:33:37.487 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Payload message
Feb 24 11:33:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:33:37 volumio volumio[1295]: info: CoreCommandRouter::servicePushState
Feb 24 11:33:37 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:33:37 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 11:33:37 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:33:37 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:33:47 volumio qobuz-connect[15639]: 20260224 11:33:47.487 [15639.15639] INFO ProtocolHandler: [0x1e4d700]: Need to send state update
Feb 24 11:33:47 volumio qobuz-connect[15639]: 20260224 11:33:47.488 [15639.15639] INFO QConnectMessageSender: [0x1e86890]: Sending StateUpdated message
Feb 24 11:33:47 volumio qobuz-connect[15639]: 20260224 11:33:47.488 [15639.15639] INFO QwspMessageSender: [0x1e86880]: Sending Payload message
Feb 24 11:33:47 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:33:47 volumio volumio[1295]: info: CoreCommandRouter::servicePushState
Feb 24 11:33:47 volumio volumio[1295]: info: CoreStateMachine::pushState
Feb 24 11:33:47 volumio volumio[1295]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 11:33:47 volumio volumio[1295]: info: CoreCommandRouter::volumioPushState
Feb 24 11:33:47 volumio volumio[1295]: info: CoreCommandRouter::volumioGetState
Feb 24 11:33:48 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 528.
Feb 24 11:33:48 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:33:48 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 24 11:33:48 volumio upmpdcli[15807]: Could not open config: /tmp/upmpdcli.conf
Feb 24 11:33:48 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 24 11:33:48 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 24 11:33:50 volumio volumio[1295]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 24 11:33:50 volumio volumio[1295]: TypeError: Cannot read properties of null (reading 'slice')
Feb 24 11:33:50 volumio volumio[1295]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41)
Feb 24 11:33:50 volumio volumio[1295]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7)
Feb 24 11:33:50 volumio volumio[1295]: at Object.onceWrapper (node:events:629:26)
Feb 24 11:33:50 volumio volumio[1295]: at ClientRequest.emit (node:events:514:28)
Feb 24 11:33:50 volumio volumio[1295]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27)
Feb 24 11:33:50 volumio volumio[1295]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17)
Feb 24 11:33:50 volumio volumio[1295]: at TLSSocket.socketOnData (node:_http_client:535:22)
Feb 24 11:33:50 volumio volumio[1295]: at TLSSocket.emit (node:events:514:28)
Feb 24 11:33:50 volumio volumio[1295]: at addChunk (node:internal/streams/readable:343:12)
Feb 24 11:33:50 volumio volumio[1295]: at readableAddChunk (node:internal/streams/readable:316:9)
Feb 24 11:33:50 volumio volumio[1295]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 24 11:33:50 volumio sudo[15822]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-24 11:32'
Feb 24 11:33:50 volumio sudo[15822]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026"
VOLUMIO_VERSION="4.096"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"