-- Logs begin at Tue 2026-01-27 22:13:52 UTC, end at Tue 2026-01-27 22:37:23 UTC. --
Jan 27 22:36:02 soggiorno volumio[958]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Jan 27 22:36:02 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Jan 27 22:36:02 soggiorno volumio[958]: info: Preparing to save Alsa Options, stopping services first
Jan 27 22:36:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:02 soggiorno volumio[958]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"Headphones"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}}
Jan 27 22:36:02 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 27 22:36:02 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:02 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:02 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 27 22:36:02 soggiorno volumio[958]: info: Found match in Cards Database: setting mixer PCM for card Headphones
Jan 27 22:36:02 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:02 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jan 27 22:36:02 soggiorno volumio[958]: info: Updating Volume Controller Parameters: Device: 0 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10
Jan 27 22:36:02 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Jan 27 22:36:02 soggiorno volumio[958]: info: Disabling external Volume Control
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 27 22:36:03 soggiorno volumio[958]: info: Preparing to generate the ALSA configuration file
Jan 27 22:36:03 soggiorno volumio[958]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Jan 27 22:36:03 soggiorno volumio[958]: info: Preparing to save Alsa Options, stopping services first
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:03 soggiorno volumio[958]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"Headphones"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}}
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 27 22:36:03 soggiorno sudo[8003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 27 22:36:03 soggiorno sudo[8003]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:03 soggiorno sudo[8003]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:03 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:03 soggiorno sudo[8007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 27 22:36:03 soggiorno sudo[8007]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:03 soggiorno systemd[1]: Stopping Volumio Qobuz Connect Service...
Jan 27 22:36:03 soggiorno qobuz-connect[1433]: 20260127 22:36:03.381 [1433.1433] INFO SampleApp: Stopping Local configuration server
Jan 27 22:36:03 soggiorno qobuz-connect[1433]: 20260127 22:36:03.391 [1433.1433] INFO SampleApp: shat down connection on UNIX socket
Jan 27 22:36:03 soggiorno systemd[1]: qobuz-connect.service: Succeeded.
Jan 27 22:36:03 soggiorno systemd[1]: Stopped Volumio Qobuz Connect Service.
Jan 27 22:36:03 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 27 22:36:03 soggiorno volumio[958]: info: Found match in Cards Database: setting mixer PCM for card Headphones
Jan 27 22:36:03 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:03 soggiorno systemd[1]: Started Volumio Qobuz Connect Service.
Jan 27 22:36:03 soggiorno sudo[8007]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:03 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jan 27 22:36:03 soggiorno volumio[958]: info: Updating Volume Controller Parameters: Device: 0 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Jan 27 22:36:03 soggiorno volumio[958]: info: Disabling external Volume Control
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 27 22:36:03 soggiorno volumio[958]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jan 27 22:36:03 soggiorno volumio[958]: info: Reading ALSA contributions from plugins.
Jan 27 22:36:03 soggiorno sudo[8020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 27 22:36:03 soggiorno sudo[8020]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:03 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:03 soggiorno sudo[8020]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:03 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:03 soggiorno sudo[8023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 27 22:36:03 soggiorno sudo[8023]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:03 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Jan 27 22:36:03 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:03 soggiorno volumio[958]: info: Executing endpoint qc_getconfig
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jan 27 22:36:03 soggiorno systemd[1]: Stopping Volumio Qobuz Connect Service...
Jan 27 22:36:03 soggiorno systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT
Jan 27 22:36:03 soggiorno systemd[1]: qobuz-connect.service: Succeeded.
Jan 27 22:36:03 soggiorno systemd[1]: Stopped Volumio Qobuz Connect Service.
Jan 27 22:36:03 soggiorno systemd[1]: Started Volumio Qobuz Connect Service.
Jan 27 22:36:03 soggiorno volumio[958]: info: VolumeController:: Volume=86 Mute =false
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 27 22:36:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:36:03 soggiorno sudo[8023]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:04 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:36:04 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:04 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 27 22:36:04 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jan 27 22:36:04 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 27 22:36:04 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jan 27 22:36:04 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:04 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:04 soggiorno volumio[958]: info: VolumeController:: Volume=86 Mute =false
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:36:04 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:36:04 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:04 soggiorno volumio[958]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Jan 27 22:36:04 soggiorno volumio[958]: info: Preparing to save Alsa Options, stopping services first
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:04 soggiorno volumio[958]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"Headphones"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}}
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 27 22:36:04 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:04 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 27 22:36:04 soggiorno volumio[958]: info: Found match in Cards Database: setting mixer PCM for card Headphones
Jan 27 22:36:04 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:04 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:05 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jan 27 22:36:05 soggiorno volumio[958]: info: Updating Volume Controller Parameters: Device: 0 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Jan 27 22:36:05 soggiorno volumio[958]: info: Disabling external Volume Control
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin
Jan 27 22:36:05 soggiorno volumio[958]: info: Executing endpoint qc_getconfig
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jan 27 22:36:05 soggiorno sudo[8049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 27 22:36:05 soggiorno sudo[8049]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:05 soggiorno qobuz-connect[8027]: 20260127 22:36:05.268 [8027.8027] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jan 27 22:36:05 soggiorno sudo[8049]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:05 soggiorno qobuz-connect[8027]: 20260127 22:36:05.288 [8027.8027] INFO VolumeManager: [0x19252d8]: Setting new playback volume: 75
Jan 27 22:36:05 soggiorno qobuz-connect[8027]: 20260127 22:36:05.288 [8027.8027] INFO VolumeManager: [0x19252d8]: Setting new mute state: 0
Jan 27 22:36:05 soggiorno qobuz-connect[8027]: 20260127 22:36:05.288 [8027.8027] INFO QobuzConnect: [0x1925ca8]: Client initialized!
Jan 27 22:36:05 soggiorno qobuz-connect[8027]: 20260127 22:36:05.288 [8027.8027] INFO SampleApp: Starting Avahi advertising, name: Soggiorno, service name: _qobuz-connect._tcp
Jan 27 22:36:05 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Jan 27 22:36:05 soggiorno volumio[958]: info: QobuzConnect: QOBUZ Connect daemon connected
Jan 27 22:36:05 soggiorno qobuz-connect[8027]: 20260127 22:36:05.323 [8027.8027] INFO LocalConfigManager: [0x1924bb8]: Starting Local Configuration server
Jan 27 22:36:05 soggiorno qobuz-connect[8027]: 20260127 22:36:05.323 [8027.8027] INFO SampleApp: Starting Local configuration server
Jan 27 22:36:05 soggiorno qobuz-connect[8027]: 20260127 22:36:05.324 [8027.8027] INFO SampleApp: Connected to UNIX socket client 0x191af60
Jan 27 22:36:05 soggiorno sudo[8054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 27 22:36:05 soggiorno sudo[8054]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:05 soggiorno systemd[1]: Stopping Volumio Qobuz Connect Service...
Jan 27 22:36:05 soggiorno qobuz-connect[8027]: 20260127 22:36:05.393 [8027.8027] INFO SampleApp: Stopping Local configuration server
Jan 27 22:36:05 soggiorno qobuz-connect[8027]: 20260127 22:36:05.404 [8027.8027] INFO SampleApp: shat down connection on UNIX socket
Jan 27 22:36:05 soggiorno systemd[1]: qobuz-connect.service: Succeeded.
Jan 27 22:36:05 soggiorno systemd[1]: Stopped Volumio Qobuz Connect Service.
Jan 27 22:36:05 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 27 22:36:05 soggiorno systemd[1]: Started Volumio Qobuz Connect Service.
Jan 27 22:36:05 soggiorno sudo[8054]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:05 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jan 27 22:36:05 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:05 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:05 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Jan 27 22:36:05 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:05 soggiorno volumio[958]: info: VolumeController:: Volume=86 Mute =false
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:36:05 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:36:05 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:05 soggiorno volumio[958]: info: Executing endpoint qc_getconfig
Jan 27 22:36:05 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jan 27 22:36:05 soggiorno qobuz-connect[8059]: 20260127 22:36:05.789 [8059.8059] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jan 27 22:36:05 soggiorno volumio[958]: info: Asound.conf file written
Jan 27 22:36:05 soggiorno qobuz-connect[8059]: 20260127 22:36:05.802 [8059.8059] INFO VolumeManager: [0x23e22d8]: Setting new playback volume: 75
Jan 27 22:36:05 soggiorno qobuz-connect[8059]: 20260127 22:36:05.803 [8059.8059] INFO VolumeManager: [0x23e22d8]: Setting new mute state: 0
Jan 27 22:36:05 soggiorno qobuz-connect[8059]: 20260127 22:36:05.803 [8059.8059] INFO QobuzConnect: [0x23e2ca8]: Client initialized!
Jan 27 22:36:05 soggiorno qobuz-connect[8059]: 20260127 22:36:05.803 [8059.8059] INFO SampleApp: Starting Avahi advertising, name: Soggiorno, service name: _qobuz-connect._tcp
Jan 27 22:36:05 soggiorno qobuz-connect[8059]: 20260127 22:36:05.830 [8059.8059] INFO LocalConfigManager: [0x23e1bb8]: Starting Local Configuration server
Jan 27 22:36:05 soggiorno qobuz-connect[8059]: 20260127 22:36:05.830 [8059.8059] INFO SampleApp: Starting Local configuration server
Jan 27 22:36:05 soggiorno qobuz-connect[8059]: 20260127 22:36:05.831 [8059.8059] INFO SampleApp: Connected to UNIX socket client 0x23d7f60
Jan 27 22:36:05 soggiorno sudo[8068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jan 27 22:36:05 soggiorno sudo[8068]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:05 soggiorno sudo[8068]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:05 soggiorno qobuz-connect[8059]: 20260127 22:36:05.947 [8059.8059] INFO SampleApp: Playback volume changed: 75
Jan 27 22:36:05 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:05 soggiorno volumio[958]: info: Output device has changed, restarting MPD
Jan 27 22:36:06 soggiorno sudo[8073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 27 22:36:06 soggiorno sudo[8073]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:06 soggiorno volumio[958]: info: Output device has changed, restarting Shairport Sync
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:06 soggiorno sudo[8073]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:06 soggiorno sudo[8076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 27 22:36:06 soggiorno sudo[8076]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:06 soggiorno volumio[958]: STREAMING PROXY: Client dropped request, destroying
Jan 27 22:36:06 soggiorno systemd[1]: Stopping Music Player Daemon...
Jan 27 22:36:06 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:06 soggiorno volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 27 22:36:06 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:06 soggiorno volumio[958]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:06 soggiorno volumio[958]: info: Preparing to generate the ALSA configuration file
Jan 27 22:36:06 soggiorno volumio[958]: info: Output device has changed, restarting MPD
Jan 27 22:36:06 soggiorno sudo[8084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 27 22:36:06 soggiorno volumio[958]: info: Output device has changed, restarting Shairport Sync
Jan 27 22:36:06 soggiorno sudo[8084]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:06 soggiorno systemd[1]: mpd.service: Succeeded.
Jan 27 22:36:06 soggiorno systemd[1]: Stopped Music Player Daemon.
Jan 27 22:36:06 soggiorno sudo[8084]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:06 soggiorno sudo[8086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 27 22:36:06 soggiorno sudo[8086]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:06 soggiorno systemd[1]: Starting Music Player Daemon...
Jan 27 22:36:06 soggiorno systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Jan 27 22:36:06 soggiorno systemd[1]: mpd.service: Succeeded.
Jan 27 22:36:06 soggiorno systemd[1]: Stopped Music Player Daemon.
Jan 27 22:36:06 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:06 soggiorno volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 27 22:36:06 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:06 soggiorno volumio[958]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno systemd[1]: Starting Music Player Daemon...
Jan 27 22:36:06 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:06 soggiorno sudo[8100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 27 22:36:06 soggiorno sudo[8100]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:06 soggiorno sudo[8100]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:06 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Jan 27 22:36:06 soggiorno volumio[958]: info: QobuzConnect: QOBUZ Connect daemon connected
Jan 27 22:36:06 soggiorno volumio[958]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jan 27 22:36:06 soggiorno volumio[958]: info: Reading ALSA contributions from plugins.
Jan 27 22:36:06 soggiorno sudo[8107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 27 22:36:06 soggiorno sudo[8093]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jan 27 22:36:06 soggiorno sudo[8107]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:06 soggiorno sudo[8093]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:06 soggiorno sudo[8106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 27 22:36:06 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:06 soggiorno sudo[8106]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:06 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:06 soggiorno sudo[8093]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:06 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:06 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:06 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:06 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:06 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:06 soggiorno volumio[958]: info: MPD Permissions set
Jan 27 22:36:06 soggiorno volumio[958]: info: MPD Permissions set
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno systemd[1]: Stopping Volumio Qobuz Connect Service...
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:06 soggiorno sudo[8106]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:06 soggiorno qobuz-connect[8059]: 20260127 22:36:06.994 [8059.8059] INFO SampleApp: Stopping Local configuration server
Jan 27 22:36:07 soggiorno qobuz-connect[8059]: 20260127 22:36:07.004 [8059.8059] INFO SampleApp: shat down connection on UNIX socket
Jan 27 22:36:07 soggiorno systemd[1]: qobuz-connect.service: Succeeded.
Jan 27 22:36:07 soggiorno systemd[1]: Stopped Volumio Qobuz Connect Service.
Jan 27 22:36:07 soggiorno sudo[8124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 27 22:36:07 soggiorno sudo[8124]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:07 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:07 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:07 soggiorno systemd[1]: Started Volumio Qobuz Connect Service.
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreStateMachine::getcurrentVolume
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreCommandRouter::volumioRetrievevolume
Jan 27 22:36:07 soggiorno sudo[8107]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:07 soggiorno systemd[1]: Stopping Volumio Qobuz Connect Service...
Jan 27 22:36:07 soggiorno systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT
Jan 27 22:36:07 soggiorno systemd[1]: qobuz-connect.service: Succeeded.
Jan 27 22:36:07 soggiorno systemd[1]: Stopped Volumio Qobuz Connect Service.
Jan 27 22:36:07 soggiorno systemd[1]: Started Volumio Qobuz Connect Service.
Jan 27 22:36:07 soggiorno sudo[8124]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:07 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:07 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:07 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Jan 27 22:36:07 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:07 soggiorno volumio[958]: info: Starting Shairport Sync
Jan 27 22:36:07 soggiorno volumio[958]: info: Starting Shairport Sync
Jan 27 22:36:07 soggiorno sudo[8143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 27 22:36:07 soggiorno sudo[8143]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:07 soggiorno sudo[8146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 27 22:36:07 soggiorno sudo[8146]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:07 soggiorno systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jan 27 22:36:07 soggiorno systemd[1]: shairport-sync.service: Succeeded.
Jan 27 22:36:07 soggiorno systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:07 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:07 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:07 soggiorno systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Jan 27 22:36:07 soggiorno sudo[8143]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreStateMachine::getcurrentVolume
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreCommandRouter::volumioRetrievevolume
Jan 27 22:36:07 soggiorno systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jan 27 22:36:07 soggiorno systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jan 27 22:36:07 soggiorno systemd[1]: shairport-sync.service: Succeeded.
Jan 27 22:36:07 soggiorno systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:07 soggiorno volumio[958]: info: Asound.conf file unchanged, so no further update is needed
Jan 27 22:36:07 soggiorno volumio[958]: info: Output device has changed, restarting MPD
Jan 27 22:36:07 soggiorno systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:07 soggiorno sudo[8146]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:07 soggiorno sudo[8153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 27 22:36:07 soggiorno sudo[8153]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:07 soggiorno volumio[958]: info: Output device has changed, restarting Shairport Sync
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:07 soggiorno sudo[8153]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:07 soggiorno sudo[8156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 27 22:36:07 soggiorno sudo[8156]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:07 soggiorno systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jan 27 22:36:07 soggiorno systemd[1]: mpd.service: Succeeded.
Jan 27 22:36:07 soggiorno systemd[1]: Stopped Music Player Daemon.
Jan 27 22:36:07 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:07 soggiorno volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 27 22:36:07 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:07 soggiorno volumio[958]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 27 22:36:07 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:08 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:08 soggiorno volumio[958]: info: Preparing to generate the ALSA configuration file
Jan 27 22:36:08 soggiorno systemd[1]: Starting Music Player Daemon...
Jan 27 22:36:08 soggiorno sudo[8170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 27 22:36:08 soggiorno sudo[8170]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:08 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:08 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:08 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:08 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:08 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:08 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:08 soggiorno sudo[8170]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:08 soggiorno volumio[958]: info: Executing endpoint qc_getconfig
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jan 27 22:36:08 soggiorno sudo[8172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 27 22:36:08 soggiorno sudo[8172]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:08 soggiorno sudo[8163]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jan 27 22:36:08 soggiorno sudo[8163]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:08 soggiorno qobuz-connect[8140]: 20260127 22:36:08.299 [8140.8140] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jan 27 22:36:08 soggiorno volumio[958]: info: Shairport-Sync Started
Jan 27 22:36:08 soggiorno sudo[8163]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:08 soggiorno volumio[958]: info: VolumeController:: Volume=86 Mute =false
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:36:08 soggiorno qobuz-connect[8140]: 20260127 22:36:08.317 [8140.8140] INFO VolumeManager: [0xe962d8]: Setting new playback volume: 75
Jan 27 22:36:08 soggiorno qobuz-connect[8140]: 20260127 22:36:08.318 [8140.8140] INFO VolumeManager: [0xe962d8]: Setting new mute state: 0
Jan 27 22:36:08 soggiorno qobuz-connect[8140]: 20260127 22:36:08.318 [8140.8140] INFO QobuzConnect: [0xe96ca8]: Client initialized!
Jan 27 22:36:08 soggiorno qobuz-connect[8140]: 20260127 22:36:08.318 [8140.8140] INFO SampleApp: Starting Avahi advertising, name: Soggiorno, service name: _qobuz-connect._tcp
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:36:08 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:36:08 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreStateMachine::updateTrackBlock
Jan 27 22:36:08 soggiorno volumio[958]: info: CorePlayQueue::getTrackBlock
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::volumioRetrievevolume
Jan 27 22:36:08 soggiorno qobuz-connect[8140]: 20260127 22:36:08.355 [8140.8140] INFO LocalConfigManager: [0xe95bb8]: Starting Local Configuration server
Jan 27 22:36:08 soggiorno qobuz-connect[8140]: 20260127 22:36:08.355 [8140.8140] INFO SampleApp: Starting Local configuration server
Jan 27 22:36:08 soggiorno qobuz-connect[8140]: 20260127 22:36:08.356 [8140.8140] INFO SampleApp: Connected to UNIX socket client 0xe8bf60
Jan 27 22:36:08 soggiorno volumio[958]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jan 27 22:36:08 soggiorno volumio[958]: info: Reading ALSA contributions from plugins.
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Jan 27 22:36:08 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Jan 27 22:36:08 soggiorno volumio[958]: info: QobuzConnect: QOBUZ Connect daemon connected
Jan 27 22:36:08 soggiorno qobuz-connect[8140]: 20260127 22:36:08.442 [8140.8140] INFO SampleApp: Stopping Local configuration server
Jan 27 22:36:08 soggiorno systemd[1]: Stopping Volumio Qobuz Connect Service...
Jan 27 22:36:08 soggiorno qobuz-connect[8140]: 20260127 22:36:08.459 [8140.8140] INFO SampleApp: shat down connection on UNIX socket
Jan 27 22:36:08 soggiorno systemd[1]: qobuz-connect.service: Succeeded.
Jan 27 22:36:08 soggiorno systemd[1]: Stopped Volumio Qobuz Connect Service.
Jan 27 22:36:08 soggiorno volumio[958]: info: MPD Permissions set
Jan 27 22:36:08 soggiorno systemd[1]: Started Volumio Qobuz Connect Service.
Jan 27 22:36:08 soggiorno sudo[8172]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:08 soggiorno volumio[958]: info: Shairport-Sync Started
Jan 27 22:36:08 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:08 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:08 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Jan 27 22:36:08 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:08 soggiorno volumio[958]: info: VolumeController:: Volume=86 Mute =false
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:36:08 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:36:08 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreStateMachine::updateTrackBlock
Jan 27 22:36:08 soggiorno volumio[958]: info: CorePlayQueue::getTrackBlock
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::volumioRetrievevolume
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:08 soggiorno volumio[958]: info: Executing endpoint qc_getconfig
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jan 27 22:36:08 soggiorno qobuz-connect[8180]: 20260127 22:36:08.915 [8180.8180] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jan 27 22:36:08 soggiorno volumio[958]: info: VolumeController:: Volume=86 Mute =false
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:36:08 soggiorno qobuz-connect[8180]: 20260127 22:36:08.929 [8180.8180] INFO VolumeManager: [0x230d2d8]: Setting new playback volume: 75
Jan 27 22:36:08 soggiorno qobuz-connect[8180]: 20260127 22:36:08.929 [8180.8180] INFO VolumeManager: [0x230d2d8]: Setting new mute state: 0
Jan 27 22:36:08 soggiorno qobuz-connect[8180]: 20260127 22:36:08.929 [8180.8180] INFO QobuzConnect: [0x230dca8]: Client initialized!
Jan 27 22:36:08 soggiorno qobuz-connect[8180]: 20260127 22:36:08.929 [8180.8180] INFO SampleApp: Starting Avahi advertising, name: Soggiorno, service name: _qobuz-connect._tcp
Jan 27 22:36:08 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:36:08 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:36:08 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:08 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:36:08 soggiorno qobuz-connect[8180]: 20260127 22:36:08.960 [8180.8180] INFO LocalConfigManager: [0x230cbb8]: Starting Local Configuration server
Jan 27 22:36:08 soggiorno qobuz-connect[8180]: 20260127 22:36:08.961 [8180.8180] INFO SampleApp: Starting Local configuration server
Jan 27 22:36:08 soggiorno qobuz-connect[8180]: 20260127 22:36:08.963 [8180.8180] INFO SampleApp: Connected to UNIX socket client 0x2302f60
Jan 27 22:36:08 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Jan 27 22:36:08 soggiorno volumio[958]: info: QobuzConnect: QOBUZ Connect daemon connected
Jan 27 22:36:09 soggiorno volumio[958]: info: Starting Shairport Sync
Jan 27 22:36:09 soggiorno qobuz-connect[8180]: 20260127 22:36:09.067 [8180.8180] INFO SampleApp: Playback volume changed: 75
Jan 27 22:36:09 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:09 soggiorno volumio[958]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Jan 27 22:36:09 soggiorno volumio[958]: info: CoreStateMachine::getcurrentVolume
Jan 27 22:36:09 soggiorno volumio[958]: info: CoreCommandRouter::volumioRetrievevolume
Jan 27 22:36:09 soggiorno sudo[8216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 27 22:36:09 soggiorno sudo[8216]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:09 soggiorno volumio[958]: info: Asound.conf file written
Jan 27 22:36:09 soggiorno systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jan 27 22:36:09 soggiorno systemd[1]: shairport-sync.service: Succeeded.
Jan 27 22:36:09 soggiorno systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:09 soggiorno sudo[8239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jan 27 22:36:09 soggiorno sudo[8239]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:09 soggiorno systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:09 soggiorno sudo[8239]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:09 soggiorno sudo[8216]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:09 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:09 soggiorno volumio[958]: info: Output device has changed, restarting MPD
Jan 27 22:36:09 soggiorno sudo[8262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 27 22:36:09 soggiorno volumio[958]: info: Output device has changed, restarting Shairport Sync
Jan 27 22:36:09 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:09 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:09 soggiorno sudo[8262]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:09 soggiorno sudo[8262]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:09 soggiorno sudo[8264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 27 22:36:09 soggiorno sudo[8264]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:09 soggiorno systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jan 27 22:36:09 soggiorno systemd[1]: mpd.service: Succeeded.
Jan 27 22:36:09 soggiorno systemd[1]: Stopped Music Player Daemon.
Jan 27 22:36:09 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:09 soggiorno volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 27 22:36:09 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:09 soggiorno volumio[958]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 27 22:36:09 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:09 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:09 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:09 soggiorno volumio[958]: info: Preparing to generate the ALSA configuration file
Jan 27 22:36:09 soggiorno systemd[1]: Starting Music Player Daemon...
Jan 27 22:36:09 soggiorno volumio[958]: info: Output device has changed, restarting MPD
Jan 27 22:36:09 soggiorno sudo[8274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 27 22:36:09 soggiorno sudo[8274]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:09 soggiorno sudo[8274]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:09 soggiorno volumio[958]: info: Output device has changed, restarting Shairport Sync
Jan 27 22:36:09 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:09 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:09 soggiorno sudo[8277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 27 22:36:09 soggiorno sudo[8277]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:09 soggiorno systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Jan 27 22:36:09 soggiorno systemd[1]: mpd.service: Succeeded.
Jan 27 22:36:09 soggiorno systemd[1]: Stopped Music Player Daemon.
Jan 27 22:36:10 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:10 soggiorno volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 27 22:36:10 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:10 soggiorno volumio[958]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:10 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:10 soggiorno systemd[1]: Starting Music Player Daemon...
Jan 27 22:36:10 soggiorno sudo[8289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 27 22:36:10 soggiorno sudo[8289]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:10 soggiorno sudo[8289]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:10 soggiorno volumio[958]: info: VolumeController:: Volume=86 Mute =false
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:36:10 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:36:10 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:10 soggiorno sudo[8295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 27 22:36:10 soggiorno volumio[958]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jan 27 22:36:10 soggiorno volumio[958]: info: Reading ALSA contributions from plugins.
Jan 27 22:36:10 soggiorno sudo[8295]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:10 soggiorno sudo[8296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 27 22:36:10 soggiorno sudo[8296]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:10 soggiorno sudo[8282]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:10 soggiorno sudo[8282]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:10 soggiorno sudo[8282]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:10 soggiorno volumio[958]: info: MPD Permissions set
Jan 27 22:36:10 soggiorno volumio[958]: info: MPD Permissions set
Jan 27 22:36:10 soggiorno volumio[958]: info: Shairport-Sync Started
Jan 27 22:36:10 soggiorno volumio[958]: info: handleBrowseUri took 2015 milliseconds
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:10 soggiorno sudo[8295]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:10 soggiorno qobuz-connect[8180]: 20260127 22:36:10.529 [8180.8180] INFO SampleApp: Stopping Local configuration server
Jan 27 22:36:10 soggiorno systemd[1]: Stopping Volumio Qobuz Connect Service...
Jan 27 22:36:10 soggiorno qobuz-connect[8180]: 20260127 22:36:10.539 [8180.8180] INFO SampleApp: shat down connection on UNIX socket
Jan 27 22:36:10 soggiorno systemd[1]: qobuz-connect.service: Succeeded.
Jan 27 22:36:10 soggiorno systemd[1]: Stopped Volumio Qobuz Connect Service.
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:10 soggiorno systemd[1]: Started Volumio Qobuz Connect Service.
Jan 27 22:36:10 soggiorno sudo[8303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 27 22:36:10 soggiorno sudo[8303]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:10 soggiorno sudo[8296]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:10 soggiorno systemd[1]: Stopping Volumio Qobuz Connect Service...
Jan 27 22:36:10 soggiorno systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT
Jan 27 22:36:10 soggiorno systemd[1]: qobuz-connect.service: Succeeded.
Jan 27 22:36:10 soggiorno systemd[1]: Stopped Volumio Qobuz Connect Service.
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:10 soggiorno volumio[958]: info: Preload queue cleared
Jan 27 22:36:10 soggiorno volumio[958]: info: Preload queue cleared
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:10 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:10 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Jan 27 22:36:10 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:10 soggiorno volumio[958]: info: VolumeController:: Volume=86 Mute =false
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:36:10 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:36:10 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreStateMachine::updateTrackBlock
Jan 27 22:36:10 soggiorno volumio[958]: info: CorePlayQueue::getTrackBlock
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::volumioRetrievevolume
Jan 27 22:36:10 soggiorno systemd[1]: Started Volumio Qobuz Connect Service.
Jan 27 22:36:10 soggiorno sudo[8303]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:10 soggiorno volumio[958]: info: Starting Shairport Sync
Jan 27 22:36:10 soggiorno volumio[958]: info: Starting Shairport Sync
Jan 27 22:36:10 soggiorno sudo[8318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 27 22:36:10 soggiorno sudo[8318]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:10 soggiorno sudo[8321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 27 22:36:10 soggiorno sudo[8321]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:10 soggiorno volumio[958]: info: Executing endpoint qc_getconfig
Jan 27 22:36:10 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jan 27 22:36:11 soggiorno systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jan 27 22:36:11 soggiorno systemd[1]: shairport-sync.service: Succeeded.
Jan 27 22:36:11 soggiorno systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:11 soggiorno qobuz-connect[8313]: 20260127 22:36:11.088 [8313.8313] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jan 27 22:36:11 soggiorno qobuz-connect[8313]: 20260127 22:36:11.112 [8313.8313] INFO VolumeManager: [0x1bab2d8]: Setting new playback volume: 75
Jan 27 22:36:11 soggiorno qobuz-connect[8313]: 20260127 22:36:11.112 [8313.8313] INFO VolumeManager: [0x1bab2d8]: Setting new mute state: 0
Jan 27 22:36:11 soggiorno qobuz-connect[8313]: 20260127 22:36:11.112 [8313.8313] INFO QobuzConnect: [0x1babca8]: Client initialized!
Jan 27 22:36:11 soggiorno qobuz-connect[8313]: 20260127 22:36:11.112 [8313.8313] INFO SampleApp: Starting Avahi advertising, name: Soggiorno, service name: _qobuz-connect._tcp
Jan 27 22:36:11 soggiorno qobuz-connect[8313]: 20260127 22:36:11.140 [8313.8313] INFO LocalConfigManager: [0x1baabb8]: Starting Local Configuration server
Jan 27 22:36:11 soggiorno qobuz-connect[8313]: 20260127 22:36:11.140 [8313.8313] INFO SampleApp: Starting Local configuration server
Jan 27 22:36:11 soggiorno qobuz-connect[8313]: 20260127 22:36:11.141 [8313.8313] INFO SampleApp: Connected to UNIX socket client 0x1ba0f60
Jan 27 22:36:11 soggiorno volumio[958]: info: Asound.conf file unchanged, so no further update is needed
Jan 27 22:36:11 soggiorno volumio[958]: info: Output device has changed, restarting MPD
Jan 27 22:36:11 soggiorno systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:11 soggiorno sudo[8318]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:11 soggiorno systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jan 27 22:36:11 soggiorno systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jan 27 22:36:11 soggiorno systemd[1]: shairport-sync.service: Succeeded.
Jan 27 22:36:11 soggiorno systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:11 soggiorno qobuz-connect[8313]: 20260127 22:36:11.238 [8313.8313] INFO SampleApp: Playback volume changed: 75
Jan 27 22:36:11 soggiorno systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:11 soggiorno sudo[8321]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:11 soggiorno volumio[958]: info: Output device has changed, restarting Shairport Sync
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:11 soggiorno sudo[8332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 27 22:36:11 soggiorno sudo[8332]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:11 soggiorno sudo[8329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 27 22:36:11 soggiorno sudo[8329]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:11 soggiorno sudo[8329]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:11 soggiorno systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jan 27 22:36:11 soggiorno systemd[1]: mpd.service: Succeeded.
Jan 27 22:36:11 soggiorno systemd[1]: Stopped Music Player Daemon.
Jan 27 22:36:11 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:11 soggiorno volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 27 22:36:11 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:11 soggiorno volumio[958]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:11 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:11 soggiorno volumio[958]: info: Preparing to generate the ALSA configuration file
Jan 27 22:36:11 soggiorno systemd[1]: Starting Music Player Daemon...
Jan 27 22:36:11 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:11 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:11 soggiorno sudo[8348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 27 22:36:11 soggiorno sudo[8348]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:11 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:11 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:11 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:11 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:11 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:11 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:11 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Jan 27 22:36:11 soggiorno volumio[958]: info: QobuzConnect: QOBUZ Connect daemon connected
Jan 27 22:36:11 soggiorno sudo[8348]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:11 soggiorno volumio[958]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jan 27 22:36:11 soggiorno volumio[958]: info: Reading ALSA contributions from plugins.
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:11 soggiorno volumio[958]: info: MPD Permissions set
Jan 27 22:36:11 soggiorno volumio[958]: info: Shairport-Sync Started
Jan 27 22:36:11 soggiorno volumio[958]: info: VolumeController:: Volume=86 Mute =false
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:36:11 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:36:11 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:11 soggiorno sudo[8350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 27 22:36:11 soggiorno sudo[8350]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:11 soggiorno sudo[8340]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jan 27 22:36:11 soggiorno sudo[8340]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:11 soggiorno volumio[958]: info: Shairport-Sync Started
Jan 27 22:36:11 soggiorno sudo[8340]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:11 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:11 soggiorno volumio[958]: info: Starting Shairport Sync
Jan 27 22:36:11 soggiorno volumio[958]: info: Asound.conf file unchanged, so no further update is needed
Jan 27 22:36:11 soggiorno volumio[958]: info: Output device has changed, restarting MPD
Jan 27 22:36:11 soggiorno systemd[1]: Stopping Volumio Qobuz Connect Service...
Jan 27 22:36:11 soggiorno qobuz-connect[8313]: 20260127 22:36:11.958 [8313.8313] INFO SampleApp: Stopping Local configuration server
Jan 27 22:36:11 soggiorno sudo[8359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 27 22:36:11 soggiorno qobuz-connect[8313]: 20260127 22:36:11.976 [8313.8313] INFO SampleApp: shat down connection on UNIX socket
Jan 27 22:36:11 soggiorno sudo[8359]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:11 soggiorno systemd[1]: qobuz-connect.service: Succeeded.
Jan 27 22:36:11 soggiorno systemd[1]: Stopped Volumio Qobuz Connect Service.
Jan 27 22:36:12 soggiorno systemd[1]: Started Volumio Qobuz Connect Service.
Jan 27 22:36:12 soggiorno sudo[8362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 27 22:36:12 soggiorno sudo[8362]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:12 soggiorno sudo[8350]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:12 soggiorno sudo[8362]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:12 soggiorno volumio[958]: info: Output device has changed, restarting Shairport Sync
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:12 soggiorno sudo[8366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 27 22:36:12 soggiorno sudo[8366]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:12 soggiorno systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jan 27 22:36:12 soggiorno systemd[1]: shairport-sync.service: Succeeded.
Jan 27 22:36:12 soggiorno systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:12 soggiorno systemd[1]: shairport-sync.service: Start request repeated too quickly.
Jan 27 22:36:12 soggiorno systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'.
Jan 27 22:36:12 soggiorno systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:12 soggiorno sudo[8359]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:12 soggiorno systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jan 27 22:36:12 soggiorno systemd[1]: mpd.service: Succeeded.
Jan 27 22:36:12 soggiorno systemd[1]: Stopped Music Player Daemon.
Jan 27 22:36:12 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:12 soggiorno volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 27 22:36:12 soggiorno volumio[958]: xcb_connection_has_error() returned true
Jan 27 22:36:12 soggiorno volumio[958]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:12 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:12 soggiorno systemd[1]: Starting Music Player Daemon...
Jan 27 22:36:12 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:12 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:12 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:12 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:12 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:12 soggiorno sudo[8379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Jan 27 22:36:12 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:12 soggiorno sudo[8379]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:12 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:12 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:12 soggiorno volumio[958]: info: MPD Permissions set
Jan 27 22:36:12 soggiorno volumio[958]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync
Jan 27 22:36:12 soggiorno volumio[958]: Job for shairport-sync.service failed.
Jan 27 22:36:12 soggiorno volumio[958]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details.
Jan 27 22:36:12 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Jan 27 22:36:12 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:12 soggiorno volumio[958]: info: Executing endpoint qc_getconfig
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jan 27 22:36:12 soggiorno sudo[8379]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:12 soggiorno sudo[8381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Jan 27 22:36:12 soggiorno sudo[8381]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:12 soggiorno qobuz-connect[8364]: 20260127 22:36:12.541 [8364.8364] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:12 soggiorno qobuz-connect[8364]: 20260127 22:36:12.557 [8364.8364] INFO VolumeManager: [0x19462d8]: Setting new playback volume: 75
Jan 27 22:36:12 soggiorno qobuz-connect[8364]: 20260127 22:36:12.557 [8364.8364] INFO VolumeManager: [0x19462d8]: Setting new mute state: 0
Jan 27 22:36:12 soggiorno qobuz-connect[8364]: 20260127 22:36:12.557 [8364.8364] INFO QobuzConnect: [0x1946ca8]: Client initialized!
Jan 27 22:36:12 soggiorno qobuz-connect[8364]: 20260127 22:36:12.557 [8364.8364] INFO SampleApp: Starting Avahi advertising, name: Soggiorno, service name: _qobuz-connect._tcp
Jan 27 22:36:12 soggiorno systemd[1]: Stopping Volumio Qobuz Connect Service...
Jan 27 22:36:12 soggiorno qobuz-connect[8364]: 20260127 22:36:12.611 [8364.8364] INFO LocalConfigManager: [0x1945bb8]: Starting Local Configuration server
Jan 27 22:36:12 soggiorno qobuz-connect[8364]: 20260127 22:36:12.611 [8364.8364] INFO SampleApp: Starting Local configuration server
Jan 27 22:36:12 soggiorno sudo[8373]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jan 27 22:36:12 soggiorno sudo[8373]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:12 soggiorno qobuz-connect[8364]: 20260127 22:36:12.619 [8364.8364] INFO SampleApp: Stopping Local configuration server
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 27 22:36:12 soggiorno qobuz-connect[8364]: 20260127 22:36:12.630 [8364.8364] INFO SampleApp: shat down connection on UNIX socket
Jan 27 22:36:12 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Jan 27 22:36:12 soggiorno volumio[958]: info: QobuzConnect: QOBUZ Connect daemon connected
Jan 27 22:36:12 soggiorno qobuz-connect[8364]: qobuz-connect-daemon: /home/volumio/qobuz-connect-daemon/sample_console_app/volumio/pipe.c:199: pipe_connect_callback: Assertion `status == 0' failed.
Jan 27 22:36:12 soggiorno sudo[8373]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:12 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:12 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Jan 27 22:36:12 soggiorno volumio[958]: info: QobuzConnect: setDeactiveState invoked
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:12 soggiorno volumio[958]: info: Starting Shairport Sync
Jan 27 22:36:12 soggiorno sudo[8393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 27 22:36:12 soggiorno sudo[8393]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:12 soggiorno systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=6/ABRT
Jan 27 22:36:12 soggiorno systemd[1]: qobuz-connect.service: Failed with result 'signal'.
Jan 27 22:36:12 soggiorno systemd[1]: Stopped Volumio Qobuz Connect Service.
Jan 27 22:36:12 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:12 soggiorno systemd[1]: Started Volumio Qobuz Connect Service.
Jan 27 22:36:12 soggiorno sudo[8381]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:12 soggiorno systemd[1]: shairport-sync.service: Start request repeated too quickly.
Jan 27 22:36:12 soggiorno systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'.
Jan 27 22:36:12 soggiorno systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver.
Jan 27 22:36:12 soggiorno sudo[8393]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:12 soggiorno volumio[958]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync
Jan 27 22:36:12 soggiorno volumio[958]: Job for shairport-sync.service failed.
Jan 27 22:36:12 soggiorno volumio[958]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details.
Jan 27 22:36:12 soggiorno volumio[958]: info: Executing endpoint qc_getconfig
Jan 27 22:36:12 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Jan 27 22:36:12 soggiorno qobuz-connect[8395]: 20260127 22:36:12.962 [8395.8395] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Jan 27 22:36:12 soggiorno volumio[958]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Jan 27 22:36:12 soggiorno volumio[958]: info: QobuzConnect: QOBUZ Connect daemon connected
Jan 27 22:36:12 soggiorno qobuz-connect[8395]: 20260127 22:36:12.981 [8395.8395] INFO VolumeManager: [0xb882d8]: Setting new playback volume: 75
Jan 27 22:36:12 soggiorno qobuz-connect[8395]: 20260127 22:36:12.982 [8395.8395] INFO VolumeManager: [0xb882d8]: Setting new mute state: 0
Jan 27 22:36:12 soggiorno qobuz-connect[8395]: 20260127 22:36:12.982 [8395.8395] INFO QobuzConnect: [0xb88ca8]: Client initialized!
Jan 27 22:36:12 soggiorno qobuz-connect[8395]: 20260127 22:36:12.983 [8395.8395] INFO SampleApp: Starting Avahi advertising, name: Soggiorno, service name: _qobuz-connect._tcp
Jan 27 22:36:13 soggiorno qobuz-connect[8395]: 20260127 22:36:13.008 [8395.8395] INFO LocalConfigManager: [0xb87bb8]: Starting Local Configuration server
Jan 27 22:36:13 soggiorno qobuz-connect[8395]: 20260127 22:36:13.008 [8395.8395] INFO SampleApp: Starting Local configuration server
Jan 27 22:36:13 soggiorno qobuz-connect[8395]: 20260127 22:36:13.009 [8395.8395] INFO SampleApp: Connected to UNIX socket client 0xb7df60
Jan 27 22:36:13 soggiorno qobuz-connect[8395]: 20260127 22:36:13.112 [8395.8395] INFO SampleApp: Playback volume changed: 75
Jan 27 22:36:13 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:15 soggiorno mpd[8391]: Jan 27 22:36 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jan 27 22:36:15 soggiorno systemd[1]: Started Music Player Daemon.
Jan 27 22:36:15 soggiorno sudo[8076]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:15 soggiorno sudo[8156]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:15 soggiorno sudo[8264]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:15 soggiorno sudo[8366]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:15 soggiorno sudo[8332]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:15 soggiorno sudo[8086]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:15 soggiorno sudo[8277]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:15 soggiorno volumio[958]: error: MPD error: The expression evaluated to a falsy value:
Jan 27 22:36:15 soggiorno volumio[958]: assert.ok(self.idling)
Jan 27 22:36:15 soggiorno volumio[958]: error: The expression evaluated to a falsy value:
Jan 27 22:36:15 soggiorno volumio[958]: assert.ok(self.idling)
Jan 27 22:36:15 soggiorno volumio[958]: error: MPD error: The expression evaluated to a falsy value:
Jan 27 22:36:15 soggiorno volumio[958]: assert.ok(self.idling)
Jan 27 22:36:15 soggiorno volumio[958]: error: The expression evaluated to a falsy value:
Jan 27 22:36:15 soggiorno volumio[958]: assert.ok(self.idling)
Jan 27 22:36:15 soggiorno volumio[958]: error: MPD error: The expression evaluated to a falsy value:
Jan 27 22:36:15 soggiorno volumio[958]: assert.ok(self.idling)
Jan 27 22:36:15 soggiorno volumio[958]: error: The expression evaluated to a falsy value:
Jan 27 22:36:15 soggiorno volumio[958]: assert.ok(self.idling)
Jan 27 22:36:15 soggiorno volumio[958]: error: MPD error: The expression evaluated to a falsy value:
Jan 27 22:36:15 soggiorno volumio[958]: assert.ok(self.idling)
Jan 27 22:36:15 soggiorno volumio[958]: error: The expression evaluated to a falsy value:
Jan 27 22:36:15 soggiorno volumio[958]: assert.ok(self.idling)
Jan 27 22:36:15 soggiorno volumio[958]: error: MPD error: The expression evaluated to a falsy value:
Jan 27 22:36:15 soggiorno volumio[958]: assert.ok(self.idling)
Jan 27 22:36:15 soggiorno volumio[958]: error: The expression evaluated to a falsy value:
Jan 27 22:36:15 soggiorno volumio[958]: assert.ok(self.idling)
Jan 27 22:36:15 soggiorno volumio[958]: error: MPD error: The expression evaluated to a falsy value:
Jan 27 22:36:15 soggiorno volumio[958]: assert.ok(self.idling)
Jan 27 22:36:15 soggiorno volumio[958]: error: The expression evaluated to a falsy value:
Jan 27 22:36:15 soggiorno volumio[958]: assert.ok(self.idling)
Jan 27 22:36:15 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:36:16 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:16 soggiorno volumio[958]: info: Listing playlists
Jan 27 22:36:16 soggiorno volumio[958]: info: Listing playlists
Jan 27 22:36:18 soggiorno sudo[8419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 27 22:36:18 soggiorno sudo[8419]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:18 soggiorno sudo[8422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 27 22:36:18 soggiorno sudo[8422]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:18 soggiorno systemd[1]: Stopping MPD Monitor Service...
Jan 27 22:36:18 soggiorno systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM
Jan 27 22:36:18 soggiorno systemd[1]: mpd_monitor.service: Succeeded.
Jan 27 22:36:18 soggiorno systemd[1]: Stopped MPD Monitor Service.
Jan 27 22:36:18 soggiorno sudo[8424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 27 22:36:18 soggiorno sudo[8424]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:18 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:18 soggiorno systemd[1]: Started MPD Monitor Service.
Jan 27 22:36:18 soggiorno sudo[8428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 27 22:36:18 soggiorno sudo[8428]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:18 soggiorno sudo[8419]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:18 soggiorno mpd_monitor.sh[8426]: MPD Monitor Service: Starting MPD Monitor Service
Jan 27 22:36:18 soggiorno sudo[8432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 27 22:36:18 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:18 soggiorno sudo[8432]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:18 soggiorno sudo[8437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 27 22:36:18 soggiorno sudo[8437]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:18 soggiorno volumio[958]: info: Successfully started MPD Monitor
Jan 27 22:36:18 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:18 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:18 soggiorno sudo[8441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Jan 27 22:36:18 soggiorno sudo[8441]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 27 22:36:18 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:18 soggiorno systemd[1]: Stopping MPD Monitor Service...
Jan 27 22:36:18 soggiorno systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM
Jan 27 22:36:18 soggiorno systemd[1]: mpd_monitor.service: Succeeded.
Jan 27 22:36:18 soggiorno systemd[1]: Stopped MPD Monitor Service.
Jan 27 22:36:18 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jan 27 22:36:18 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:18 soggiorno volumio[958]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jan 27 22:36:18 soggiorno systemd[1]: Started MPD Monitor Service.
Jan 27 22:36:18 soggiorno sudo[8424]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:18 soggiorno sudo[8432]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:18 soggiorno sudo[8422]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:18 soggiorno mpd_monitor.sh[8443]: MPD Monitor Service: Starting MPD Monitor Service
Jan 27 22:36:18 soggiorno sudo[8437]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:18 soggiorno volumio[958]: info: Successfully started MPD Monitor
Jan 27 22:36:18 soggiorno volumio[958]: info: Successfully started MPD Monitor
Jan 27 22:36:18 soggiorno sudo[8428]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:18 soggiorno volumio[958]: info: Successfully started MPD Monitor
Jan 27 22:36:19 soggiorno sudo[8441]: pam_unix(sudo:session): session closed for user root
Jan 27 22:36:19 soggiorno volumio[958]: info: Successfully started MPD Monitor
Jan 27 22:36:23 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Jan 27 22:36:24 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Jan 27 22:36:25 soggiorno volumio[958]: info: handleBrowseUri took 2173 milliseconds
Jan 27 22:36:25 soggiorno volumio[958]: info: Preload queue cleared
Jan 27 22:36:27 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:27 soggiorno volumio[958]: info: handleBrowseUri took 2466 milliseconds
Jan 27 22:36:27 soggiorno volumio[958]: info: Preload queue cleared
Jan 27 22:36:36 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:37 soggiorno volumio[958]: info: Listing playlists
Jan 27 22:36:37 soggiorno volumio[958]: info: Listing playlists
Jan 27 22:36:46 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:50 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri
Jan 27 22:36:51 soggiorno volumio[958]: info: handleBrowseUri took 1125 milliseconds
Jan 27 22:36:51 soggiorno volumio[958]: info: Preload queue cleared
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/356640485
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/371151716
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/345272318
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/376197213
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/356715774
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/358924396
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/368667597
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/360795194
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/366934653
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/380550627
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/352795430
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/373994222
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/358978032
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/330882807
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/379279413
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/359935065
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/370148940
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/370012959
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/365757600
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/370166660
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/371068859
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/369757608
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/365120477
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/367299966
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/361695250
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/360304235
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/374793626
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/366045118
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/369637600
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/361915994
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/374526683
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/365476620
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/358096914
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/363457255
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/356661599
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/364684706
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/367442775
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/372609451
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/357977606
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/358923125
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/362968316
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/361933220
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/365451298
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/372631798
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/365541469
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/374791990
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/364635268
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/360516271
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/371428097
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/371067156
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/359439342
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/376070956
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/363897176
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/374704400
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/366800041
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/346689761
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/363131820
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/371585564
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/371797899
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/371036967
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/368137729
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/366627328
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/370514052
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/364340531
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/361621075
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/360543617
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/365647829
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/380378273
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/360092415
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/367084506
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/357973280
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/367547125
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/363300617
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/367085958
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/365798792
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/363687213
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/364040314
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/369802299
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/356254932
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/351975111
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/369595704
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/365769326
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/352650903
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/353166834
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/358922767
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/368432621
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/364476834
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/368061728
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/355337270
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/363105868
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/368462587
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/363096340
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/365311828
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/362881897
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/367510646
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/371674532
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/366798012
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/324461106
Jan 27 22:36:51 soggiorno volumio[958]: info: Preloading song: qobuz://song/369991933
Jan 27 22:36:51 soggiorno volumio[958]: info: Exploding uri qobuz://song/356640485 in service qobuz
Jan 27 22:36:51 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:51 soggiorno volumio[958]: info: Exploding uri qobuz://song/371151716 in service qobuz
Jan 27 22:36:51 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:51 soggiorno volumio[958]: info: Exploding uri qobuz://song/345272318 in service qobuz
Jan 27 22:36:51 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:51 soggiorno volumio[958]: info: Exploding uri qobuz://song/376197213 in service qobuz
Jan 27 22:36:51 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:51 soggiorno volumio[958]: info: Exploding uri qobuz://song/356715774 in service qobuz
Jan 27 22:36:51 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:51 soggiorno volumio[958]: info: Exploding uri qobuz://song/358924396 in service qobuz
Jan 27 22:36:51 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:51 soggiorno volumio[958]: info: Exploding uri qobuz://song/368667597 in service qobuz
Jan 27 22:36:51 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:51 soggiorno volumio[958]: info: Exploding uri qobuz://song/360795194 in service qobuz
Jan 27 22:36:51 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:51 soggiorno volumio[958]: info: Exploding uri qobuz://song/366934653 in service qobuz
Jan 27 22:36:51 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:51 soggiorno volumio[958]: info: Exploding uri qobuz://song/380550627 in service qobuz
Jan 27 22:36:51 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:51 soggiorno volumio[958]: info: Exploding uri qobuz://song/352795430 in service qobuz
Jan 27 22:36:51 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:51 soggiorno volumio[958]: info: Exploding uri qobuz://song/373994222 in service qobuz
Jan 27 22:36:51 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:51 soggiorno volumio[958]: info: explodeUri took 540 milliseconds
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/358978032 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/330882807 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: explodeUri took 802 milliseconds
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/379279413 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/359935065 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/370148940 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: explodeUri took 717 milliseconds
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/370012959 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: explodeUri took 852 milliseconds
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/365757600 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/370166660 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/371068859 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: explodeUri took 786 milliseconds
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/369757608 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: explodeUri took 797 milliseconds
Jan 27 22:36:52 soggiorno volumio[958]: info: explodeUri took 753 milliseconds
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/365120477 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: explodeUri took 915 milliseconds
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/367299966 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/361695250 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/360304235 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/374793626 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/366045118 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: explodeUri took 1012 milliseconds
Jan 27 22:36:52 soggiorno volumio[958]: info: explodeUri took 998 milliseconds
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/369637600 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/361915994 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/374526683 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: explodeUri took 977 milliseconds
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/365476620 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:52 soggiorno volumio[958]: info: Exploding uri qobuz://song/358096914 in service qobuz
Jan 27 22:36:52 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1039 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1005 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1014 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/363457255 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1055 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/356661599 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/364684706 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/367442775 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/372609451 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1093 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1008 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1108 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/357977606 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/358923125 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 816 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 959 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 967 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/362968316 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/361933220 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/365451298 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/372631798 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/365541469 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1269 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1141 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 980 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1296 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1388 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/374791990 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/364635268 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/360516271 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/371428097 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1120 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1122 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/371067156 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: Exploding uri qobuz://song/359439342 in service qobuz
Jan 27 22:36:53 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1002 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1075 milliseconds
Jan 27 22:36:53 soggiorno volumio[958]: info: explodeUri took 1084 milliseconds
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/376070956 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/363897176 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/374704400 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: explodeUri took 1104 milliseconds
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/366800041 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/346689761 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/363131820 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/371585564 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/371797899 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: explodeUri took 1440 milliseconds
Jan 27 22:36:54 soggiorno volumio[958]: info: explodeUri took 1136 milliseconds
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/371036967 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/368137729 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: explodeUri took 1187 milliseconds
Jan 27 22:36:54 soggiorno volumio[958]: info: explodeUri took 1195 milliseconds
Jan 27 22:36:54 soggiorno volumio[958]: info: explodeUri took 1203 milliseconds
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/366627328 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/370514052 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/364340531 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: Exploding uri qobuz://song/361621075 in service qobuz
Jan 27 22:36:54 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:54 soggiorno volumio[958]: info: explodeUri took 1344 milliseconds
Jan 27 22:36:54 soggiorno volumio[958]: info: explodeUri took 1638 milliseconds
Jan 27 22:36:54 soggiorno volumio[958]: info: explodeUri took 1905 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1599 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/360543617 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/365647829 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/380378273 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/360092415 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/367084506 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/357973280 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/367547125 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/363300617 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1441 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1276 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1265 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1210 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1533 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1538 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1541 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/367085958 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/365798792 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/363687213 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/364040314 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/369802299 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1214 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1454 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1372 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/356254932 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/351975111 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/369595704 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/365769326 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1472 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1688 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/352650903 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/353166834 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/358922767 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/368432621 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/364476834 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/368061728 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/355337270 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/363105868 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: Exploding uri qobuz://song/368462587 in service qobuz
Jan 27 22:36:55 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1853 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1633 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1641 milliseconds
Jan 27 22:36:55 soggiorno volumio[958]: info: explodeUri took 1650 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: Exploding uri qobuz://song/363096340 in service qobuz
Jan 27 22:36:56 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:56 soggiorno volumio[958]: info: Exploding uri qobuz://song/365311828 in service qobuz
Jan 27 22:36:56 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:56 soggiorno volumio[958]: info: Exploding uri qobuz://song/362881897 in service qobuz
Jan 27 22:36:56 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1760 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1761 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1650 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1784 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1851 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1791 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1858 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: Exploding uri qobuz://song/367510646 in service qobuz
Jan 27 22:36:56 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:56 soggiorno volumio[958]: info: Exploding uri qobuz://song/371674532 in service qobuz
Jan 27 22:36:56 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:56 soggiorno volumio[958]: info: Exploding uri qobuz://song/366798012 in service qobuz
Jan 27 22:36:56 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:56 soggiorno volumio[958]: info: Exploding uri qobuz://song/324461106 in service qobuz
Jan 27 22:36:56 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:56 soggiorno volumio[958]: info: Exploding uri qobuz://song/369991933 in service qobuz
Jan 27 22:36:56 soggiorno volumio[958]: https://prod.vlmapi.io/v2/qobuz/explodeUri
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1353 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1746 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1501 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1514 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1509 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1725 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1922 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1940 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1713 milliseconds
Jan 27 22:36:56 soggiorno volumio[958]: info: explodeUri took 1724 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1954 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1742 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1732 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1701 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1901 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1846 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1885 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1887 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1754 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1754 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1779 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1683 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1684 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1693 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1706 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1726 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1866 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1732 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1978 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1569 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1571 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: explodeUri took 1572 milliseconds
Jan 27 22:36:57 soggiorno volumio[958]: info: Listing playlists
Jan 27 22:36:57 soggiorno volumio[958]: info: Listing playlists
Jan 27 22:36:58 soggiorno volumio[958]: info: explodeUri took 2036 milliseconds
Jan 27 22:36:58 soggiorno volumio[958]: info: explodeUri took 1765 milliseconds
Jan 27 22:36:58 soggiorno volumio[958]: info: explodeUri took 1766 milliseconds
Jan 27 22:36:59 soggiorno volumio[958]: info: Preload queue cleared
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreCommandRouter::volumioAddQueueItems
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreStateMachine::addQueueItems
Jan 27 22:36:59 soggiorno volumio[958]: info: CorePlayQueue::addQueueItems
Jan 27 22:36:59 soggiorno volumio[958]: info: Preload queue cleared
Jan 27 22:36:59 soggiorno volumio[958]: info: Adding Item to queue: qobuz://song/376197213
Jan 27 22:36:59 soggiorno volumio[958]: info: Using cached record of: qobuz://song/376197213
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushQueue
Jan 27 22:36:59 soggiorno volumio[958]: info: CorePlayQueue::saveQueue
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreStateMachine::updateTrackBlock
Jan 27 22:36:59 soggiorno volumio[958]: info: CorePlayQueue::getTrackBlock
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreCommandRouter::volumioPlay
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreStateMachine::play index 37
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreStateMachine::stop
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreStateMachine::play index undefined
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 27 22:36:59 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreStateMachine::startPlaybackTimer
Jan 27 22:36:59 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Jan 27 22:36:59 soggiorno volumio[958]: info: [1769553419296] ControllerQobuz::clearAddPlayTrack
Jan 27 22:36:59 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand stop
Jan 27 22:36:59 soggiorno volumio[958]: info: sendMpdCommand stop took 13 milliseconds
Jan 27 22:36:59 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand clear
Jan 27 22:36:59 soggiorno volumio[958]: info:
Jan 27 22:36:59 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:36:59 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:36:59 soggiorno volumio[958]: info: sendMpdCommand clear took 3 milliseconds
Jan 27 22:36:59 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/376197213"
Jan 27 22:36:59 soggiorno volumio[958]: info:
Jan 27 22:36:59 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:36:59 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:36:59 soggiorno volumio[958]: info:
Jan 27 22:36:59 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:36:59 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:36:59 soggiorno volumio[958]: STREAMING PROXY: Handling url /?data=qobuz://song/376197213
Jan 27 22:36:59 soggiorno volumio[958]: info:
Jan 27 22:36:59 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:36:59 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:36:59 soggiorno volumio[958]: info:
Jan 27 22:36:59 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:36:59 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:36:59 soggiorno volumio[958]: info:
Jan 27 22:36:59 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:36:59 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:36:59 soggiorno volumio[958]: info:
Jan 27 22:36:59 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:36:59 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:36:59 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:36:59 soggiorno volumio[958]: info: ------------------------------ 22ms
Jan 27 22:36:59 soggiorno volumio[958]: info: Executing endpoint getStreamUrlqobuz
Jan 27 22:36:59 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Jan 27 22:36:59 soggiorno volumio[958]: info: getStreamUrl took 542 milliseconds
Jan 27 22:36:59 soggiorno volumio[958]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1878034&eid=376197213&fmt=7&profile=raw&app_id=539451548&cid=3774670&etsp=1769557019&hmac=ZWBRf96Rkbksb_CjpAxJRPOQDrI
Jan 27 22:37:00 soggiorno volumio[958]: STREAMING PROXY: Response: 200, length: 85202195
Jan 27 22:37:00 soggiorno volumio[958]: STREAMING PROXY: Client dropped request, destroying
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/376197213"
Jan 27 22:37:00 soggiorno volumio[958]: info: Preload queue cleared
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::volumioAddQueueItems
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::addQueueItems
Jan 27 22:37:00 soggiorno volumio[958]: info: CorePlayQueue::addQueueItems
Jan 27 22:37:00 soggiorno volumio[958]: info: Preload queue cleared
Jan 27 22:37:00 soggiorno volumio[958]: info: Adding Item to queue: qobuz://song/376197213
Jan 27 22:37:00 soggiorno volumio[958]: info: Using cached record of: qobuz://song/376197213
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushQueue
Jan 27 22:37:00 soggiorno volumio[958]: info: CorePlayQueue::saveQueue
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::updateTrackBlock
Jan 27 22:37:00 soggiorno volumio[958]: info: CorePlayQueue::getTrackBlock
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::volumioPlay
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::play index 37
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::stop
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::play index undefined
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 27 22:37:00 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::startPlaybackTimer
Jan 27 22:37:00 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Jan 27 22:37:00 soggiorno volumio[958]: info: [1769553420519] ControllerQobuz::clearAddPlayTrack
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand stop
Jan 27 22:37:00 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:00 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:00 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:00 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:00 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:00 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 1208ms
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 1206ms
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 1205ms
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 1202ms
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 1199ms
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 1197ms
Jan 27 22:37:00 soggiorno volumio[958]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/376197213" took 37 milliseconds
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand play
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: STREAMING PROXY: Handling url /?data=qobuz://song/376197213
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info: sendMpdCommand stop took 25 milliseconds
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 22ms
Jan 27 22:37:00 soggiorno volumio[958]: info: sendMpdCommand play took 18 milliseconds
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 17ms
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 16ms
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 14ms
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 12ms
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 9ms
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 8ms
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand clear
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:00 soggiorno volumio[958]: info: sendMpdCommand clear took 14 milliseconds
Jan 27 22:37:00 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/376197213"
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:00 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:00 soggiorno volumio[958]: STREAMING PROXY: Handling url /?data=qobuz://song/376197213
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:00 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:00 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:00 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:00 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:00 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:00 soggiorno volumio[958]: info:
Jan 27 22:37:00 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:00 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:00 soggiorno volumio[958]: info: Executing endpoint getStreamUrlqobuz
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Jan 27 22:37:00 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 46ms
Jan 27 22:37:00 soggiorno volumio[958]: info: sendMpdCommand status took 44 milliseconds
Jan 27 22:37:00 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:00 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:00 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:00 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:00 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:00 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 27 22:37:00 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService stop
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus stop
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:00 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:00 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:00 soggiorno volumio[958]: info: No code
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:00 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:00 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:00 soggiorno volumio[958]: info: ------------------------------ 84ms
Jan 27 22:37:00 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:00 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:00 soggiorno volumio[958]: info: Executing endpoint getStreamUrlqobuz
Jan 27 22:37:00 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Jan 27 22:37:01 soggiorno volumio[958]: info: getStreamUrl took 621 milliseconds
Jan 27 22:37:01 soggiorno volumio[958]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1878034&eid=376197213&fmt=7&profile=raw&app_id=539451548&cid=3774670&etsp=1769557021&hmac=van7Nr8j69jFTKzjsNWO_deOzZI
Jan 27 22:37:01 soggiorno volumio[958]: info: getStreamUrl took 726 milliseconds
Jan 27 22:37:01 soggiorno volumio[958]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1878034&eid=376197213&fmt=7&profile=raw&app_id=539451548&cid=3774670&etsp=1769557021&hmac=van7Nr8j69jFTKzjsNWO_deOzZI
Jan 27 22:37:01 soggiorno volumio[958]: STREAMING PROXY: Response: 200, length: 85202195
Jan 27 22:37:01 soggiorno volumio[958]: STREAMING PROXY: Response: 200, length: 85202195
Jan 27 22:37:01 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/376197213"
Jan 27 22:37:01 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:01 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:01 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:01 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:01 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:01 soggiorno volumio[958]: error: updateQueue error: null
Jan 27 22:37:01 soggiorno volumio[958]: info: ------------------------------ 1363ms
Jan 27 22:37:01 soggiorno volumio[958]: info: sendMpdCommand status took 1360 milliseconds
Jan 27 22:37:01 soggiorno volumio[958]: STREAMING PROXY: Client dropped request, destroying
Jan 27 22:37:01 soggiorno volumio[958]: info: ------------------------------ 1359ms
Jan 27 22:37:01 soggiorno volumio[958]: info: sendMpdCommand status took 1358 milliseconds
Jan 27 22:37:01 soggiorno volumio[958]: info: ------------------------------ 1357ms
Jan 27 22:37:01 soggiorno volumio[958]: info: sendMpdCommand status took 1355 milliseconds
Jan 27 22:37:01 soggiorno volumio[958]: info: ------------------------------ 1354ms
Jan 27 22:37:01 soggiorno volumio[958]: info: sendMpdCommand status took 1353 milliseconds
Jan 27 22:37:01 soggiorno volumio[958]: info: ------------------------------ 1351ms
Jan 27 22:37:01 soggiorno volumio[958]: info: sendMpdCommand status took 1350 milliseconds
Jan 27 22:37:01 soggiorno volumio[958]: info: ------------------------------ 1349ms
Jan 27 22:37:01 soggiorno volumio[958]: info: sendMpdCommand status took 1348 milliseconds
Jan 27 22:37:01 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:01 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:01 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:01 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:01 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:01 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:01 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:01 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:01 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 27 22:37:01 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService stop
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus stop
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:01 soggiorno volumio[958]: info: No code
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:01 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:01 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:01 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 27 22:37:01 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService stop
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus stop
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:01 soggiorno volumio[958]: info: No code
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:01 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:01 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:01 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 27 22:37:01 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService stop
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus stop
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:01 soggiorno volumio[958]: info: No code
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:01 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:01 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:01 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:01 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 27 22:37:01 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService stop
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus stop
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:01 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:02 soggiorno volumio[958]: info: No code
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:02 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:02 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:02 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 27 22:37:02 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService stop
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus stop
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:02 soggiorno volumio[958]: info: No code
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:02 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:02 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:02 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 27 22:37:02 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService stop
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus stop
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:02 soggiorno volumio[958]: info: No code
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:02 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 1552ms
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 1549ms
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 1548ms
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 1546ms
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 1545ms
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 1543ms
Jan 27 22:37:02 soggiorno volumio[958]: info:
Jan 27 22:37:02 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:02 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:02 soggiorno volumio[958]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/376197213" took 215 milliseconds
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 27 22:37:02 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand play
Jan 27 22:37:02 soggiorno volumio[958]: info:
Jan 27 22:37:02 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:02 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:02 soggiorno volumio[958]: info:
Jan 27 22:37:02 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:02 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:02 soggiorno volumio[958]: STREAMING PROXY: Handling url /?data=qobuz://song/376197213
Jan 27 22:37:02 soggiorno volumio[958]: info:
Jan 27 22:37:02 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:02 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:02 soggiorno volumio[958]: info:
Jan 27 22:37:02 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:02 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:02 soggiorno volumio[958]: info:
Jan 27 22:37:02 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:02 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:02 soggiorno volumio[958]: info:
Jan 27 22:37:02 soggiorno volumio[958]: ---------------------------- MPD announces system playlist update
Jan 27 22:37:02 soggiorno volumio[958]: info: Ignoring MPD Status Update
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.z9CpTLxknSh9JO5dix3jHSJHKHu2.0c1a2bb1f178bac5b0f5937d7c238aee.state.status'
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 147ms
Jan 27 22:37:02 soggiorno volumio[958]: info: sendMpdCommand play took 146 milliseconds
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 145ms
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 143ms
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 141ms
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 139ms
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 138ms
Jan 27 22:37:02 soggiorno volumio[958]: info: ------------------------------ 136ms
Jan 27 22:37:02 soggiorno volumio[958]: info: Executing endpoint getStreamUrlqobuz
Jan 27 22:37:02 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Jan 27 22:37:03 soggiorno volumio[958]: info: getStreamUrl took 743 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1878034&eid=376197213&fmt=7&profile=raw&app_id=539451548&cid=3774670&etsp=1769557022&hmac=tM-3XvAl8EthbXSCWaeTclrF63I
Jan 27 22:37:03 soggiorno volumio[958]: STREAMING PROXY: Response: 200, length: 85202195
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 36 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 33 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 30 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 27 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 26 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 23 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 22 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 21 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 18 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 17 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 13 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: info:
Jan 27 22:37:03 soggiorno volumio[958]: ---------------------------- MPD announces state update: player
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::getState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand status
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 28 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 24 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 17 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 17 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 17 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 14 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand status took 10 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseState
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus stop
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 267ms
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 339ms
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 338ms
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 335ms
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 334ms
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 333ms
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 332ms
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 331ms
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 331ms
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 330ms
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 327ms
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 295 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 294 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: info: sendMpdCommand playlistinfo took 272 milliseconds
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: verbose: ControllerMpd::parseTrackInfo
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ControllerMpd::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::servicePushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CorePlayQueue::getTrack 37
Jan 27 22:37:03 soggiorno volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"376197213","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/376197213","trackType":"qobuz"}
Jan 27 22:37:03 soggiorno volumio[958]: verbose: CURRENT POSITION 37
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState stateService play
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::syncState currentStatus play
Jan 27 22:37:03 soggiorno volumio[958]: info: Received an update from plugin. extracting info from payload
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreStateMachine::pushState
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioPushState
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output update for this device
Jan 27 22:37:03 soggiorno volumio[958]: info: MRS: Pushing multiroomSync output
Jan 27 22:37:03 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 407ms
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 404ms
Jan 27 22:37:03 soggiorno volumio[958]: info: ------------------------------ 384ms
Jan 27 22:37:07 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:17 soggiorno volumio[958]: info: CoreCommandRouter::volumioGetState
Jan 27 22:37:17 soggiorno volumio[958]: info: Listing playlists
Jan 27 22:37:17 soggiorno volumio[958]: info: Listing playlists
Jan 27 22:37:22 soggiorno volumio[958]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay
Jan 27 22:37:22 soggiorno volumio[958]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom
Jan 27 22:37:22 soggiorno volumio[958]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 27 22:37:22 soggiorno volumio[958]: TypeError: Cannot read property 'then' of undefined
Jan 27 22:37:22 soggiorno volumio[958]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9)
Jan 27 22:37:22 soggiorno volumio[958]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30)
Jan 27 22:37:22 soggiorno volumio[958]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1467:26)
Jan 27 22:37:22 soggiorno volumio[958]: at Socket.emit (events.js:315:20)
Jan 27 22:37:22 soggiorno volumio[958]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Jan 27 22:37:22 soggiorno volumio[958]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Jan 27 22:37:22 soggiorno volumio[958]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 27 22:37:23 soggiorno sudo[8614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-27 22:36
Jan 27 22:37:23 soggiorno sudo[8614]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"