Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.203 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Received SetState message: Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.203 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playing state: Paused Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.203 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playback position: Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.203 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Queue version: Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.203 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Current track: Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.203 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Next track: Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.203 [6510.6510] INFO MediaEngine: [0x6abee0]: Pausing playback Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.203 [6510.6510] INFO AudioRenderer: [0x6ac100]: Pausing audio renderer Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.204 [6510.6510] INFO SampleApp: Pausing playback Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.204 [6510.6510] ERROR SampleApp: Unable to pause ALSA audio sink: Function not implemented (-38) Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.204 [6510.6510] ERROR AudioRenderer: [0x6ac100]: Playback error occurred Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.204 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending PlaybackError message Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.204 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.204 [6510.6510] INFO SampleApp: Playback state changed: Stopped Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.204 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming ended event Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.204 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.204 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.204 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.205 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.269 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Received SetState message: Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.269 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playing state: Playing Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.269 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playback position: 0 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.269 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Queue version: 2.1 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.269 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Current track: TID: 33933828, QID: 4, Context UUID: ac56db57-0390-4179-a160-8e002031f280 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.270 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Next track: TID: 33933829, QID: 5, Context UUID: ac56db57-0390-4179-a160-8e002031f280 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.270 [6510.6510] INFO MediaEngine: [0x6abee0]: Reseting Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.270 [6510.6510] INFO MediaEngine: [0x6abee0]: Stopping playback, clearing tracks Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.270 [6510.6510] INFO MediaEngine: [0x6abee0]: Initiating playback Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.270 [6510.6510] INFO AudioRenderer: [0x6ac100]: Reseting audio renderer Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.270 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.270 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.271 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.271 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting current track: 33933828, initial offset: 0ms Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.271 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Clearing all streams Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.271 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 4]: Disposing of audio stream Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.271 [6510.6510] INFO ContentFetcher: [0x85cfa0]: Canceling download Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.277 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 5]: Disposing of audio stream Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.277 [6510.6510] INFO ContentFetcher: [0xa26ac8]: Canceling download Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.281 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: New stream: 6 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.281 [6510.6510] INFO HttpDownloader: [0x853ef0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=beb1ab97da9643b34bcfd17470d95c56&request_ts=1771759681&track_id=33933828 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.281 [6510.6510] INFO HttpDownloader: [0x6ed538]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=33933828 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.282 [6510.6510] INFO HttpDownloader: [0x6e4ff0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=92a6fb9ea222a39a0784a739a0803871&request_ts=1771759681&track_id=33933828 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.282 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 6]: Running audio stream Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.283 [6510.6510] INFO SampleApp: [Stream 4]: Audio stream has been disposed of Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.283 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting next track: 33933829 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.284 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: New stream: 7 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.284 [6510.6510] INFO HttpDownloader: [0x974a18]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=e58a4f57eef9538b6e352b644807ab8b&request_ts=1771759681&track_id=33933829 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.284 [6510.6510] INFO HttpDownloader: [0x8c7aa0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=33933829 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.284 [6510.6510] INFO HttpDownloader: [0x8b7a10]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=e8141a7e5668db1f74fbf4d27f4e1240&request_ts=1771759681&track_id=33933829 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.285 [6510.6510] INFO SampleApp: [Stream 5]: Audio stream has been disposed of Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.285 [6510.6510] INFO MediaEngine: [0x6abee0]: Waiting for current stream to start before starting audio renderer Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.358 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 6]: Metadata became available: Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.359 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Title: The Delicate Place Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.359 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Artist: Spoon Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.359 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album: Gimme Fiction Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.359 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.395 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 6]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933828&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763281&hmac=RUxEXHsLyS5M5S_ZnB1LgjmPhs8 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.409 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 7]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933829&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763281&hmac=6ZJ5cjG5IRndMKnztey1ckvO5ec Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.467 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 7]: Metadata became available: Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.467 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Title: Sister Jack Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.467 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Artist: Spoon Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.467 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album: Gimme Fiction Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.467 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.514 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 6]: stream information have been fetched Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.514 [6510.6510] INFO UrlAudioSource: [0x83a428]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933828&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763281&hmac=RUxEXHsLyS5M5S_ZnB1LgjmPhs8 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.514 [6510.6510] INFO ContentFetcher: [0x6ecdd0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933828&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763281&hmac=RUxEXHsLyS5M5S_ZnB1LgjmPhs8, offset: 0 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.514 [6510.6510] INFO AudioRenderer: [0x6ac100]: Starting audio renderer, initial playback state: Playing Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.514 [6510.6510] INFO SampleApp: [Stream 6]: New audio stream (starting from 0ms) Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.514 [6510.6510] INFO SampleApp: [Stream 6]: Stream metadata became available: Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.514 [6510.6510] INFO SampleApp: Title: The Delicate Place Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.514 [6510.6510] INFO SampleApp: Artist: Spoon Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.514 [6510.6510] INFO SampleApp: Album: Gimme Fiction Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.514 [6510.6510] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.515 [6510.6510] INFO SampleApp: Initiating playback, initial state: Playing Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.517 [6510.6510] INFO SampleApp: Playback state changed: Playing Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.517 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming started event Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.517 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.517 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.517 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.517 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.518 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending FileAudioQualityChanged message Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.518 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: QobuzConnect: alread currrent service, send playback confirmation Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:01 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.604 [6510.6510] INFO UrlAudioSource: [0x83a428]: Content info extracted Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.604 [6510.6510] INFO UrlAudioSource: [0x83a428]: Size: 24167963 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.605 [6510.7399] INFO AudioDecoder: [0x8b4ab0]: Stream info: Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.605 [6510.7399] INFO AudioDecoder: [0x8b4ab0]: Total samples: 9812544 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.605 [6510.7399] INFO AudioDecoder: [0x8b4ab0]: Sample rate: 44100 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.605 [6510.7399] INFO AudioDecoder: [0x8b4ab0]: Channel count: 2 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.605 [6510.7399] INFO AudioDecoder: [0x8b4ab0]: Bits per sample: 16 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.605 [6510.7399] INFO AudioDecoder: [0x8b4ab0]: Duration: 222506 Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.606 [6510.6510] INFO UrlAudioSource: [0x83a428]: Audio properties have changed Feb 22 12:28:01 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:01.688 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 7]: stream information have been fetched Feb 22 12:28:04 volumio-sydcesar-02 volumio[1112]: info: Tunnel connection is inactive, restarting it Feb 22 12:28:04 volumio-sydcesar-02 volumio[1112]: info: Starting Tunnel 1 Feb 22 12:28:04 volumio-sydcesar-02 volumio[1112]: info: Starting Tunnel Connection Checker Feb 22 12:28:04 volumio-sydcesar-02 sudo[7406]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Feb 22 12:28:04 volumio-sydcesar-02 sudo[7406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 12:28:04 volumio-sydcesar-02 systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 22 12:28:04 volumio-sydcesar-02 sudo[7406]: pam_unix(sudo:session): session closed for user root Feb 22 12:28:04 volumio-sydcesar-02 volumio[1112]: info: Remote SSH Started Feb 22 12:28:04 volumio-sydcesar-02 autossh[7409]: port set to 0, monitoring disabled Feb 22 12:28:04 volumio-sydcesar-02 autossh[7409]: starting ssh (count 1) Feb 22 12:28:04 volumio-sydcesar-02 autossh[7409]: ssh child pid is 7412 Feb 22 12:28:04 volumio-sydcesar-02 volumio[1112]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 22 12:28:04 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:04 volumio-sydcesar-02 volumiossh-tunnel[7412]: Warning: Permanently added '[eu10.myvolumio.org]:2222' (RSA) to the list of known hosts. Feb 22 12:28:10 volumio-sydcesar-02 volumiossh-tunnel[7412]: Connection to eu10.myvolumio.org closed by remote host. Feb 22 12:28:10 volumio-sydcesar-02 autossh[7409]: ssh exited prematurely with status 255; autossh exiting Feb 22 12:28:10 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Feb 22 12:28:10 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Feb 22 12:28:10 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 1. Feb 22 12:28:10 volumio-sydcesar-02 systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Feb 22 12:28:10 volumio-sydcesar-02 systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 22 12:28:10 volumio-sydcesar-02 autossh[7428]: port set to 0, monitoring disabled Feb 22 12:28:11 volumio-sydcesar-02 autossh[7428]: starting ssh (count 1) Feb 22 12:28:11 volumio-sydcesar-02 autossh[7428]: ssh child pid is 7431 Feb 22 12:28:11 volumio-sydcesar-02 volumiossh-tunnel[7431]: ssh: connect to host eu10.myvolumio.org port 2222: Connection refused Feb 22 12:28:11 volumio-sydcesar-02 autossh[7428]: ssh exited prematurely with status 255; autossh exiting Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 2. Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 22 12:28:11 volumio-sydcesar-02 autossh[7433]: port set to 0, monitoring disabled Feb 22 12:28:11 volumio-sydcesar-02 autossh[7433]: starting ssh (count 1) Feb 22 12:28:11 volumio-sydcesar-02 autossh[7433]: ssh child pid is 7436 Feb 22 12:28:11 volumio-sydcesar-02 volumiossh-tunnel[7436]: ssh: connect to host eu10.myvolumio.org port 2222: Connection refused Feb 22 12:28:11 volumio-sydcesar-02 autossh[7433]: ssh exited prematurely with status 255; autossh exiting Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Feb 22 12:28:11 volumio-sydcesar-02 sudo[7438]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 22 12:28:11 volumio-sydcesar-02 sudo[7438]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 12:28:11 volumio-sydcesar-02 sudo[7438]: pam_unix(sudo:session): session closed for user root Feb 22 12:28:11 volumio-sydcesar-02 sudo[7440]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 12:28:11 volumio-sydcesar-02 sudo[7440]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 3. Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Feb 22 12:28:11 volumio-sydcesar-02 sudo[7440]: pam_unix(sudo:session): session closed for user root Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: verbose: New Socket.io Connection to 192.168.1.56 from 192.168.1.55 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Edg/145.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 22 12:28:11 volumio-sydcesar-02 autossh[7445]: port set to 0, monitoring disabled Feb 22 12:28:11 volumio-sydcesar-02 autossh[7445]: starting ssh (count 1) Feb 22 12:28:11 volumio-sydcesar-02 autossh[7445]: ssh child pid is 7448 Feb 22 12:28:11 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:11.518 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:11 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:11.518 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:11 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:11.518 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:11 volumio-sydcesar-02 volumiossh-tunnel[7448]: ssh: connect to host eu10.myvolumio.org port 2222: Connection refused Feb 22 12:28:11 volumio-sydcesar-02 autossh[7445]: ssh exited prematurely with status 255; autossh exiting Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: Received Get System Info Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: Discovery: Getting this device information Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: Listing playlists Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 4. Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Feb 22 12:28:11 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 22 12:28:11 volumio-sydcesar-02 autossh[7451]: port set to 0, monitoring disabled Feb 22 12:28:11 volumio-sydcesar-02 autossh[7451]: starting ssh (count 1) Feb 22 12:28:11 volumio-sydcesar-02 autossh[7451]: ssh child pid is 7454 Feb 22 12:28:11 volumio-sydcesar-02 volumiossh-tunnel[7454]: ssh: connect to host eu10.myvolumio.org port 2222: Connection refused Feb 22 12:28:11 volumio-sydcesar-02 autossh[7451]: ssh exited prematurely with status 255; autossh exiting Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 5. Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Start request repeated too quickly. Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Feb 22 12:28:11 volumio-sydcesar-02 systemd[1]: Failed to start sshtunnel.service - MyVolumio SSH Tunnel. Feb 22 12:28:12 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: Received Get System Info Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: Discovery: Getting this device information Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPause Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pause Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::stPlaybackTimer Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::servicePause Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePause Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: QobuzConnect: Received pause Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.831 [6510.6510] INFO MediaEngine: [0x6abee0]: Pausing playback Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.831 [6510.6510] INFO AudioRenderer: [0x6ac100]: Pausing audio renderer Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.831 [6510.6510] INFO SampleApp: Pausing playback Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.831 [6510.6510] ERROR SampleApp: Unable to pause ALSA audio sink: Function not implemented (-38) Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.831 [6510.6510] ERROR AudioRenderer: [0x6ac100]: Playback error occurred Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.831 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending PlaybackError message Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.831 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.831 [6510.6510] INFO SampleApp: Playback state changed: Stopped Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.831 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming ended event Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.831 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.831 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.831 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.832 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Received SetState message: Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playing state: Playing Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playback position: 0 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Queue version: 2.1 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Current track: TID: 33933829, QID: 5, Context UUID: ac56db57-0390-4179-a160-8e002031f280 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Next track: TID: 33933830, QID: 6, Context UUID: ac56db57-0390-4179-a160-8e002031f280 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO MediaEngine: [0x6abee0]: Reseting Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO MediaEngine: [0x6abee0]: Stopping playback, clearing tracks Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO MediaEngine: [0x6abee0]: Initiating playback Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO AudioRenderer: [0x6ac100]: Reseting audio renderer Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting current track: 33933829, initial offset: 0ms Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Clearing all streams Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 6]: Disposing of audio stream Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.890 [6510.6510] INFO ContentFetcher: [0x6ecdd0]: Canceling download Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:13 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.895 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: New stream: 8 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.895 [6510.6510] INFO HttpDownloader: [0x853ef0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=af5d9637f610ad9a139dd6f54e0f93d5&request_ts=1771759693&track_id=33933829 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.895 [6510.6510] INFO HttpDownloader: [0x6e6e70]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=33933829 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.895 [6510.6510] INFO HttpDownloader: [0x97ad88]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=e4ac295754f89e488af30160b39195bc&request_ts=1771759693&track_id=33933829 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.895 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 8]: Running audio stream Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.896 [6510.6510] INFO SampleApp: [Stream 6]: Audio stream has been disposed of Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.897 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting next track: 33933830 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.897 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: New stream: 9 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.897 [6510.6510] INFO HttpDownloader: [0x833038]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=18de34c440439cd91d56ec9b03ead0a8&request_ts=1771759693&track_id=33933830 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.897 [6510.6510] INFO HttpDownloader: [0x7de4f8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=33933830 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.897 [6510.6510] INFO HttpDownloader: [0x8e8990]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=9a5959ff0d0d9188f0ac0d677fc97e0b&request_ts=1771759693&track_id=33933830 Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.898 [6510.6510] INFO MediaEngine: [0x6abee0]: Waiting for current stream to start before starting audio renderer Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.982 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 8]: Metadata became available: Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.982 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Title: Sister Jack Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.982 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Artist: Spoon Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.982 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album: Gimme Fiction Feb 22 12:28:13 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:13.982 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.007 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 8]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933829&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763293&hmac=VvTd8tdXcToiB8kxURKV0TXQfdM Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.029 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 9]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933830&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763293&hmac=D3TndofDd4IVSkjY_4wdI7M0Ntg Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.050 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 8]: stream information have been fetched Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.050 [6510.6510] INFO UrlAudioSource: [0x8cbe48]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933829&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763293&hmac=VvTd8tdXcToiB8kxURKV0TXQfdM Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.050 [6510.6510] INFO ContentFetcher: [0x9e76a8]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933829&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763293&hmac=VvTd8tdXcToiB8kxURKV0TXQfdM, offset: 0 Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.050 [6510.6510] INFO AudioRenderer: [0x6ac100]: Starting audio renderer, initial playback state: Playing Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.050 [6510.6510] INFO SampleApp: [Stream 8]: New audio stream (starting from 0ms) Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.050 [6510.6510] INFO SampleApp: [Stream 8]: Stream metadata became available: Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.050 [6510.6510] INFO SampleApp: Title: Sister Jack Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.050 [6510.6510] INFO SampleApp: Artist: Spoon Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.050 [6510.6510] INFO SampleApp: Album: Gimme Fiction Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.050 [6510.6510] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: QobuzConnect: alread currrent service, send playback confirmation Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.051 [6510.6510] INFO SampleApp: Initiating playback, initial state: Playing Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.053 [6510.6510] INFO SampleApp: Playback state changed: Playing Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.053 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming started event Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.053 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.053 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.053 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.053 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.054 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending FileAudioQualityChanged message Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.054 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.057 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 9]: stream information have been fetched Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.111 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 9]: Metadata became available: Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.111 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Title: I Summon You Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.112 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Artist: Spoon Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.112 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album: Gimme Fiction Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.112 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: Received Get System Info Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: Discovery: Getting this device information Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:14 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.466 [6510.6510] INFO UrlAudioSource: [0x8cbe48]: Content info extracted Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.466 [6510.6510] INFO UrlAudioSource: [0x8cbe48]: Size: 30617470 Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.467 [6510.7455] INFO AudioDecoder: [0x8da1e0]: Stream info: Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.467 [6510.7455] INFO AudioDecoder: [0x8da1e0]: Total samples: 9502080 Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.467 [6510.7455] INFO AudioDecoder: [0x8da1e0]: Sample rate: 44100 Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.467 [6510.7455] INFO AudioDecoder: [0x8da1e0]: Channel count: 2 Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.467 [6510.7455] INFO AudioDecoder: [0x8da1e0]: Bits per sample: 16 Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.467 [6510.7455] INFO AudioDecoder: [0x8da1e0]: Duration: 215466 Feb 22 12:28:14 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:14.467 [6510.6510] INFO UrlAudioSource: [0x8cbe48]: Audio properties have changed Feb 22 12:28:22 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Received SetState message: Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playing state: Playing Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playback position: 0 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Queue version: 3.1 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Current track: TID: 33933827, QID: 3, Context UUID: a3fe9c9f-4be9-4284-ae7e-37237ed8e873 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Next track: TID: 33933828, QID: 4, Context UUID: a3fe9c9f-4be9-4284-ae7e-37237ed8e873 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO MediaEngine: [0x6abee0]: Stopping playback, clearing tracks Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO MediaEngine: [0x6abee0]: Initiating playback Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO AudioRenderer: [0x6ac100]: Stopping audio renderer Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO SampleApp: Stopping playback Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Clearing all streams Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 8]: Disposing of audio stream Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.855 [6510.6510] INFO ContentFetcher: [0x9e76a8]: Canceling download Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.859 [6510.6510] INFO SampleApp: Playback state changed: Stopped Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.859 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming ended event Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.859 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.859 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.859 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.859 [6510.6510] INFO SampleApp: [Stream 8]: Audio stream has been disposed of Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.859 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting current track: 33933827, initial offset: 0ms Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.859 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Clearing all streams Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.859 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: New stream: 10 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.860 [6510.6510] INFO HttpDownloader: [0x6e4ea0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=3f11db41e2f1348e9321c389e4943341&request_ts=1771759703&track_id=33933827 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.860 [6510.6510] INFO HttpDownloader: [0x6c0ca8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=33933827 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.860 [6510.6510] INFO HttpDownloader: [0x90d1a0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=6d374770b9eb9c5e8e955de20ca3a2e0&request_ts=1771759703&track_id=33933827 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.860 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 10]: Running audio stream Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.860 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.861 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting next track: 33933828 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.861 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: New stream: 11 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.861 [6510.6510] INFO HttpDownloader: [0x7bcc48]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=af282ef13719cadea08791bd11db3fab&request_ts=1771759703&track_id=33933828 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.861 [6510.6510] INFO HttpDownloader: [0x896810]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=33933828 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.861 [6510.6510] INFO HttpDownloader: [0x7d4c98]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=d1998baff670af3234442b11de5e7474&request_ts=1771759703&track_id=33933828 Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.862 [6510.6510] INFO MediaEngine: [0x6abee0]: Waiting for current stream to start before starting audio renderer Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:23 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.930 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 11]: Metadata became available: Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.930 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Title: The Delicate Place Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.930 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Artist: Spoon Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.930 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album: Gimme Fiction Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.930 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.932 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 10]: Metadata became available: Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.932 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Title: My Mathematical Mind Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.932 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Artist: Spoon Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.932 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album: Gimme Fiction Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.932 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.972 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 10]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933827&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763303&hmac=yjTyK4Ha04q33dkzc3lgLTsRr6I Feb 22 12:28:23 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:23.980 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 11]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933828&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763303&hmac=gEG1QlXJy_2RIj9oNN05sXRJK6A Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.006 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 11]: stream information have been fetched Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.020 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 10]: stream information have been fetched Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.020 [6510.6510] INFO UrlAudioSource: [0x7a4940]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933827&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763303&hmac=yjTyK4Ha04q33dkzc3lgLTsRr6I Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.020 [6510.6510] INFO ContentFetcher: [0x9e76a8]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933827&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763303&hmac=yjTyK4Ha04q33dkzc3lgLTsRr6I, offset: 0 Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.020 [6510.6510] INFO AudioRenderer: [0x6ac100]: Starting audio renderer, initial playback state: Playing Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.020 [6510.6510] INFO SampleApp: [Stream 10]: New audio stream (starting from 0ms) Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.020 [6510.6510] INFO SampleApp: [Stream 10]: Stream metadata became available: Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.020 [6510.6510] INFO SampleApp: Title: My Mathematical Mind Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.020 [6510.6510] INFO SampleApp: Artist: Spoon Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.020 [6510.6510] INFO SampleApp: Album: Gimme Fiction Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.020 [6510.6510] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: QobuzConnect: alread currrent service, send playback confirmation Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.021 [6510.6510] INFO SampleApp: Initiating playback, initial state: Playing Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.023 [6510.6510] INFO SampleApp: Playback state changed: Playing Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.023 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming started event Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.023 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.023 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.024 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.024 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending FileAudioQualityChanged message Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.024 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.079 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.100 [6510.6510] INFO UrlAudioSource: [0x7a4940]: Content info extracted Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.100 [6510.6510] INFO UrlAudioSource: [0x7a4940]: Size: 39411162 Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.102 [6510.7471] INFO AudioDecoder: [0x911608]: Stream info: Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.102 [6510.7471] INFO AudioDecoder: [0x911608]: Total samples: 13326432 Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.102 [6510.7471] INFO AudioDecoder: [0x911608]: Sample rate: 44100 Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.102 [6510.7471] INFO AudioDecoder: [0x911608]: Channel count: 2 Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.102 [6510.7471] INFO AudioDecoder: [0x911608]: Bits per sample: 16 Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.102 [6510.7471] INFO AudioDecoder: [0x911608]: Duration: 302186 Feb 22 12:28:24 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:24.102 [6510.6510] INFO UrlAudioSource: [0x7a4940]: Audio properties have changed Feb 22 12:28:31 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 22 12:28:31 volumio-sydcesar-02 volumio[1112]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 22 12:28:31 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 22 12:28:31 volumio-sydcesar-02 volumio[1112]: info: Received Get System Version Feb 22 12:28:31 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 12:28:31 volumio-sydcesar-02 volumio[1112]: info: Received Get System Info Feb 22 12:28:31 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 22 12:28:31 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 12:28:31 volumio-sydcesar-02 volumio[1112]: info: Discovery: Getting this device information Feb 22 12:28:31 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:31 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.023 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.023 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.024 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Received SetState message: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playing state: Paused Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playback position: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Queue version: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Current track: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Next track: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO MediaEngine: [0x6abee0]: Pausing playback Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO AudioRenderer: [0x6ac100]: Pausing audio renderer Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO SampleApp: Pausing playback Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] ERROR SampleApp: Unable to pause ALSA audio sink: Function not implemented (-38) Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] ERROR AudioRenderer: [0x6ac100]: Playback error occurred Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending PlaybackError message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO SampleApp: Playback state changed: Stopped Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming ended event Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.187 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.188 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.245 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Received SetState message: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.245 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playing state: Playing Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.245 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playback position: 0 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.245 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Queue version: 3.1 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.245 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Current track: TID: 33933828, QID: 4, Context UUID: a3fe9c9f-4be9-4284-ae7e-37237ed8e873 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.245 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Next track: TID: 33933829, QID: 5, Context UUID: a3fe9c9f-4be9-4284-ae7e-37237ed8e873 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.245 [6510.6510] INFO MediaEngine: [0x6abee0]: Reseting Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.245 [6510.6510] INFO MediaEngine: [0x6abee0]: Stopping playback, clearing tracks Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.246 [6510.6510] INFO MediaEngine: [0x6abee0]: Initiating playback Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.246 [6510.6510] INFO AudioRenderer: [0x6ac100]: Reseting audio renderer Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.246 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.246 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.246 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.246 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting current track: 33933828, initial offset: 0ms Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.246 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Clearing all streams Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.246 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 10]: Disposing of audio stream Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.246 [6510.6510] INFO ContentFetcher: [0x9e76a8]: Canceling download Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.250 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: New stream: 12 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.251 [6510.6510] INFO HttpDownloader: [0x6e4ea0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=4509688a07647f8789f358924405d95d&request_ts=1771759714&track_id=33933828 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.251 [6510.6510] INFO HttpDownloader: [0xa181c8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=33933828 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.251 [6510.6510] INFO HttpDownloader: [0x6e4ff0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=bb84089ffdae35c4ba3abfd476c5f560&request_ts=1771759714&track_id=33933828 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.251 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 12]: Running audio stream Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.252 [6510.6510] INFO SampleApp: [Stream 10]: Audio stream has been disposed of Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.252 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting next track: 33933829 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.252 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: New stream: 13 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.252 [6510.6510] INFO HttpDownloader: [0x831728]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=72d04ef89d94bcada36fa9638b2d9da9&request_ts=1771759714&track_id=33933829 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.252 [6510.6510] INFO HttpDownloader: [0x8fe590]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=33933829 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.252 [6510.6510] INFO HttpDownloader: [0x838198]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=5fdc193e9aabad65f8bd2004f180f37a&request_ts=1771759714&track_id=33933829 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.253 [6510.6510] INFO MediaEngine: [0x6abee0]: Waiting for current stream to start before starting audio renderer Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.254 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Received SetState message: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.254 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playing state: Paused Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.254 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playback position: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.254 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Queue version: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.254 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Current track: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.254 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Next track: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.254 [6510.6510] INFO MediaEngine: [0x6abee0]: Pausing playback Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.327 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 13]: Metadata became available: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.327 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Title: Sister Jack Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.327 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Artist: Spoon Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.327 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album: Gimme Fiction Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.327 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.335 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 12]: Metadata became available: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.335 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Title: The Delicate Place Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.335 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Artist: Spoon Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.335 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album: Gimme Fiction Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.335 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.350 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 13]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933829&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763314&hmac=9nnJWTsIhkAOXzEyhhUfJ1ZlFOU Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.397 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 12]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933828&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763314&hmac=U6pbYxgrzMc0o3_oEPzSEV2hX7U Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.406 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 12]: stream information have been fetched Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.407 [6510.6510] INFO UrlAudioSource: [0x83a428]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933828&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763314&hmac=U6pbYxgrzMc0o3_oEPzSEV2hX7U Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.407 [6510.6510] INFO ContentFetcher: [0xa2b7b0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933828&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763314&hmac=U6pbYxgrzMc0o3_oEPzSEV2hX7U, offset: 0 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.407 [6510.6510] INFO AudioRenderer: [0x6ac100]: Starting audio renderer, initial playback state: Playing Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.407 [6510.6510] INFO SampleApp: [Stream 12]: New audio stream (starting from 0ms) Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.407 [6510.6510] INFO SampleApp: [Stream 12]: Stream metadata became available: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.407 [6510.6510] INFO SampleApp: Title: The Delicate Place Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.407 [6510.6510] INFO SampleApp: Artist: Spoon Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.407 [6510.6510] INFO SampleApp: Album: Gimme Fiction Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.407 [6510.6510] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: QobuzConnect: alread currrent service, send playback confirmation Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.408 [6510.6510] INFO SampleApp: Initiating playback, initial state: Playing Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.410 [6510.6510] INFO SampleApp: Playback state changed: Playing Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.410 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming started event Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.410 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.410 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.411 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.411 [6510.6510] INFO AudioRenderer: [0x6ac100]: Pausing audio renderer Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.411 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.411 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending FileAudioQualityChanged message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.411 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.411 [6510.6510] INFO SampleApp: Pausing playback Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.412 [6510.6510] ERROR SampleApp: Unable to pause ALSA audio sink: Function not implemented (-38) Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.412 [6510.6510] ERROR AudioRenderer: [0x6ac100]: Playback error occurred Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.412 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending PlaybackError message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.412 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.412 [6510.6510] INFO SampleApp: Playback state changed: Stopped Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.412 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming ended event Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.412 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.412 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.412 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Received SetState message: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playing state: Playing Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playback position: 0 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Queue version: 3.1 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Current track: TID: 33933829, QID: 5, Context UUID: a3fe9c9f-4be9-4284-ae7e-37237ed8e873 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Next track: TID: 33933830, QID: 6, Context UUID: a3fe9c9f-4be9-4284-ae7e-37237ed8e873 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO MediaEngine: [0x6abee0]: Reseting Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO MediaEngine: [0x6abee0]: Stopping playback, clearing tracks Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO MediaEngine: [0x6abee0]: Initiating playback Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO AudioRenderer: [0x6ac100]: Reseting audio renderer Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.479 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting current track: 33933829, initial offset: 0ms Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.480 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Clearing all streams Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.480 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 12]: Disposing of audio stream Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.480 [6510.6510] INFO ContentFetcher: [0xa2b7b0]: Canceling download Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.484 [6510.6510] INFO HttpDownloader: [0x838198]: Canceling download Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.484 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: New stream: 14 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.484 [6510.6510] INFO HttpDownloader: [0x6e4ea0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=72d04ef89d94bcada36fa9638b2d9da9&request_ts=1771759714&track_id=33933829 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.484 [6510.6510] INFO HttpDownloader: [0x78ded8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=33933829 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.484 [6510.6510] INFO HttpDownloader: [0x6e6e70]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=5fdc193e9aabad65f8bd2004f180f37a&request_ts=1771759714&track_id=33933829 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.484 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 14]: Running audio stream Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.485 [6510.6510] INFO SampleApp: [Stream 12]: Audio stream has been disposed of Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.485 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting next track: 33933830 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.486 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: New stream: 15 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.486 [6510.6510] INFO HttpDownloader: [0x7d2148]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=d6ea19d6e190517077ff21834ecc155e&request_ts=1771759714&track_id=33933830 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.486 [6510.6510] INFO HttpDownloader: [0x6b4450]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=33933830 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.486 [6510.6510] INFO HttpDownloader: [0x7f1198]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=43524b9d2da7eea487115343330022f5&request_ts=1771759714&track_id=33933830 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.487 [6510.6510] INFO MediaEngine: [0x6abee0]: Waiting for current stream to start before starting audio renderer Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.571 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.576 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 14]: Metadata became available: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.576 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Title: Sister Jack Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.576 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Artist: Spoon Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.576 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album: Gimme Fiction Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.576 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.579 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 15]: Metadata became available: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.580 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Title: I Summon You Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.580 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Artist: Spoon Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.580 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album: Gimme Fiction Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.580 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.588 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 14]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933829&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763314&hmac=9nnJWTsIhkAOXzEyhhUfJ1ZlFOU Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.620 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 15]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933830&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763314&hmac=POfd00NRtSiGhUQjxnxNlDQqHt4 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.635 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 14]: stream information have been fetched Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.635 [6510.6510] INFO UrlAudioSource: [0x9e5120]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933829&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763314&hmac=9nnJWTsIhkAOXzEyhhUfJ1ZlFOU Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.635 [6510.6510] INFO ContentFetcher: [0x83cb20]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933829&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763314&hmac=9nnJWTsIhkAOXzEyhhUfJ1ZlFOU, offset: 0 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.635 [6510.6510] INFO AudioRenderer: [0x6ac100]: Starting audio renderer, initial playback state: Playing Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.635 [6510.6510] INFO SampleApp: [Stream 14]: New audio stream (starting from 0ms) Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.635 [6510.6510] INFO SampleApp: [Stream 14]: Stream metadata became available: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.635 [6510.6510] INFO SampleApp: Title: Sister Jack Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.635 [6510.6510] INFO SampleApp: Artist: Spoon Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.635 [6510.6510] INFO SampleApp: Album: Gimme Fiction Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.635 [6510.6510] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: QobuzConnect: alread currrent service, send playback confirmation Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.636 [6510.6510] INFO SampleApp: Initiating playback, initial state: Playing Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.638 [6510.6510] INFO SampleApp: Playback state changed: Playing Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.638 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming started event Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.638 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.638 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.638 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.638 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending FileAudioQualityChanged message Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.639 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.641 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 15]: stream information have been fetched Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:34 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.717 [6510.6510] INFO UrlAudioSource: [0x9e5120]: Content info extracted Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.717 [6510.6510] INFO UrlAudioSource: [0x9e5120]: Size: 30617470 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.718 [6510.7486] INFO AudioDecoder: [0x860648]: Stream info: Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.718 [6510.7486] INFO AudioDecoder: [0x860648]: Total samples: 9502080 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.718 [6510.7486] INFO AudioDecoder: [0x860648]: Sample rate: 44100 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.718 [6510.7486] INFO AudioDecoder: [0x860648]: Channel count: 2 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.718 [6510.7486] INFO AudioDecoder: [0x860648]: Bits per sample: 16 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.718 [6510.7486] INFO AudioDecoder: [0x860648]: Duration: 215466 Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.718 [6510.6510] INFO UrlAudioSource: [0x9e5120]: Audio properties have changed Feb 22 12:28:34 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:34.759 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Feb 22 12:28:44 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:44.639 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:44 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:44.639 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:44 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:44.639 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:44 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:44 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:44 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:44 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:44 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:44 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:44 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:44 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Received SetState message: Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playing state: Playing Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Playback position: 0 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Queue version: 4.1 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Current track: TID: 33933827, QID: 3, Context UUID: 70149812-f1c6-4bab-a484-fe82794c153f Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Next track: TID: 33933828, QID: 4, Context UUID: 70149812-f1c6-4bab-a484-fe82794c153f Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO MediaEngine: [0x6abee0]: Stopping playback, clearing tracks Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO MediaEngine: [0x6abee0]: Initiating playback Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO AudioRenderer: [0x6ac100]: Stopping audio renderer Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO SampleApp: Stopping playback Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Clearing all streams Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 14]: Disposing of audio stream Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.653 [6510.6510] INFO ContentFetcher: [0x83cb20]: Canceling download Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.657 [6510.6510] INFO SampleApp: Playback state changed: Stopped Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.657 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming ended event Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.657 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.657 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.657 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.657 [6510.6510] INFO SampleApp: [Stream 14]: Audio stream has been disposed of Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.657 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting current track: 33933827, initial offset: 0ms Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.657 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Clearing all streams Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.657 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: New stream: 16 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.657 [6510.6510] INFO HttpDownloader: [0x7349a8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=197632a0dcf4e6c7bc3fddce41c1a0f4&request_ts=1771759727&track_id=33933827 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.657 [6510.6510] INFO HttpDownloader: [0x6e4ea0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=33933827 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.658 [6510.6510] INFO HttpDownloader: [0x6e6e70]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=0039e82561cc2b014111daa6e1250207&request_ts=1771759727&track_id=33933827 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.658 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 16]: Running audio stream Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.658 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.659 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting next track: 33933828 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.659 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: New stream: 17 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.659 [6510.6510] INFO HttpDownloader: [0x7b0368]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=47dd55718e9f0c19ed9613f04adf77c2&request_ts=1771759727&track_id=33933828 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.659 [6510.6510] INFO HttpDownloader: [0xa0ef98]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=33933828 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.659 [6510.6510] INFO HttpDownloader: [0x7e6dd0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=873d874f93271a56552c86687e00a4c5&request_ts=1771759727&track_id=33933828 Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.660 [6510.6510] INFO MediaEngine: [0x6abee0]: Waiting for current stream to start before starting audio renderer Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.738 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 16]: Metadata became available: Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.738 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Title: My Mathematical Mind Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.738 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Artist: Spoon Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.738 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album: Gimme Fiction Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.739 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.760 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 16]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933827&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763327&hmac=cJY7veSHozG8SNV4uUtljKvcs34 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.797 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 17]: Metadata became available: Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.797 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Title: The Delicate Place Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.797 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Artist: Spoon Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.797 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album: Gimme Fiction Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.797 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.801 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 17]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933828&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763327&hmac=EO4mPEcuuse7wWMdorUbhIUB3Dc Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.813 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 17]: stream information have been fetched Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.814 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 16]: stream information have been fetched Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.815 [6510.6510] INFO UrlAudioSource: [0x9e5120]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933827&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763327&hmac=cJY7veSHozG8SNV4uUtljKvcs34 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.815 [6510.6510] INFO ContentFetcher: [0x857f98]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=1989252&eid=33933827&fmt=6&profile=raw&app_id=174516466&cid=1503740&etsp=1771763327&hmac=cJY7veSHozG8SNV4uUtljKvcs34, offset: 0 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.815 [6510.6510] INFO AudioRenderer: [0x6ac100]: Starting audio renderer, initial playback state: Playing Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.815 [6510.6510] INFO SampleApp: [Stream 16]: New audio stream (starting from 0ms) Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.815 [6510.6510] INFO SampleApp: [Stream 16]: Stream metadata became available: Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.815 [6510.6510] INFO SampleApp: Title: My Mathematical Mind Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.815 [6510.6510] INFO SampleApp: Artist: Spoon Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.815 [6510.6510] INFO SampleApp: Album: Gimme Fiction Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.815 [6510.6510] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/53/04/0744861110453_600.jpg Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: QobuzConnect: alread currrent service, send playback confirmation Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.816 [6510.6510] INFO SampleApp: Initiating playback, initial state: Playing Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.818 [6510.6510] INFO SampleApp: Playback state changed: Playing Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.818 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming started event Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.818 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Need to send state update Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.818 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending StateUpdated message Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.818 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.818 [6510.6510] INFO QConnectMessageSender: [0x6dede8]: Sending FileAudioQualityChanged message Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.818 [6510.6510] INFO QwspMessageSender: [0x7a43f8]: Sending Payload message Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:47 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.876 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.891 [6510.6510] INFO UrlAudioSource: [0x9e5120]: Content info extracted Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.891 [6510.6510] INFO UrlAudioSource: [0x9e5120]: Size: 39411162 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.892 [6510.7517] INFO AudioDecoder: [0x8fa4f8]: Stream info: Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.892 [6510.7517] INFO AudioDecoder: [0x8fa4f8]: Total samples: 13326432 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.892 [6510.7517] INFO AudioDecoder: [0x8fa4f8]: Sample rate: 44100 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.892 [6510.7517] INFO AudioDecoder: [0x8fa4f8]: Channel count: 2 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.892 [6510.7517] INFO AudioDecoder: [0x8fa4f8]: Bits per sample: 16 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.892 [6510.7517] INFO AudioDecoder: [0x8fa4f8]: Duration: 302186 Feb 22 12:28:47 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:47.893 [6510.6510] INFO UrlAudioSource: [0x9e5120]: Audio properties have changed Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.882 [6510.6510] INFO ProtocolHandler: [0x6ac620]: Received SetActive message: inactive Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.882 [6510.6510] INFO PlaybackSessionManager: [0x6abc48]: Stopping playback session maintenance Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.882 [6510.6510] INFO ActiveStateManager: [0x6aa870]: Setting new active state: inactive Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.882 [6510.6510] INFO MediaEngine: [0x6abee0]: Stopping playback, clearing tracks Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.882 [6510.6510] INFO MediaEngine: [0x6abee0]: Reseting Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.882 [6510.6510] INFO SampleApp: Renderer is now inactive Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.882 [6510.6510] INFO AudioRenderer: [0x6ac100]: Stopping audio renderer Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.882 [6510.6510] INFO SampleApp: Stopping playback Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.883 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: Clearing all streams Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.883 [6510.6510] INFO AudioStreamManager: [0x6abfc8]: [Stream 16]: Disposing of audio stream Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.883 [6510.6510] INFO ContentFetcher: [0x857f98]: Canceling download Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.887 [6510.6510] INFO SampleApp: Playback state changed: Stopped Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.887 [6510.6510] INFO StreamingEventReporter: [0x6aca38]: Reporting streaming ended event Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.887 [6510.6510] INFO HttpDownloader: [0x6aca90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.887 [6510.6510] INFO SampleApp: [Stream 16]: Audio stream has been disposed of Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.887 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting current track: NONE Feb 22 12:28:53 volumio-sydcesar-02 qobuz-connect[6510]: 20260222 12:28:53.887 [6510.6510] INFO MediaEngine: [0x6abee0]: Setting next track: NONE Feb 22 12:28:53 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:28:53 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::servicePushState Feb 22 12:28:53 volumio-sydcesar-02 volumio[1112]: info: CoreStateMachine::pushState Feb 22 12:28:53 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:28:53 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioPushState Feb 22 12:28:53 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output update for this device Feb 22 12:28:53 volumio-sydcesar-02 volumio[1112]: info: MRS: Pushing multiroomSync output Feb 22 12:28:53 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetState Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: Retrieving Cloud Streaming UI Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: Getting Tidal Cloud Configuration Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: Getting Qobuz Cloud Configuration Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: Asking plugin for UI Config Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: Getting Spotify Cloud Configuration Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: Asking plugin for UI Config Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: Saving Spotify Acccount Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: Got it Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: Got Tidal Cloud Configuration Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: Got it Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetBrowseSources Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetBrowseSources Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioGetBrowseSources Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 22 12:29:24 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 22 12:29:28 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 22 12:29:29 volumio-sydcesar-02 volumio[1112]: info: Disabling MyMusic plugin upnp_browser Feb 22 12:29:29 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMedia Servers Feb 22 12:29:29 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 12:29:29 volumio-sydcesar-02 volumio[1112]: info: Disabling plugin upnp_browser Feb 22 12:29:29 volumio-sydcesar-02 volumio[1112]: info: Done. Feb 22 12:29:32 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 22 12:29:35 volumio-sydcesar-02 volumio[1112]: info: Disabling MyMusic plugin upnp Feb 22 12:29:35 volumio-sydcesar-02 sudo[7582]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Feb 22 12:29:35 volumio-sydcesar-02 sudo[7582]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 12:29:35 volumio-sydcesar-02 systemd[1]: Stopping upmpdcli.service - UPnP Renderer front-end to MPD... Feb 22 12:29:36 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: info: Enabling MyMusic plugin upnp Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: info: Enabling plugin upnp Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: info: Loading plugin "upnp"... Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: info: [1771759778433] Starting Upmpd Daemon Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: Error: listen EADDRINUSE: address already in use :::6599 Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: at Server.setupListenHandle [as _listen2] (node:net:1872:16) Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: at listenInCluster (node:net:1920:12) Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: at Server.listen (node:net:2008:7) Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: code: 'EADDRINUSE', Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: errno: -98, Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: syscall: 'listen', Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: address: '::', Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: port: 6599 Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: } Feb 22 12:29:38 volumio-sydcesar-02 volumio[1112]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 12:29:38 volumio-sydcesar-02 sudo[7613]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-22 12:28' Feb 22 12:29:38 volumio-sydcesar-02 sudo[7613]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"