Feb 07 10:08:01 volumio qobuz-connect[3287]: 20260207 10:08:01.985 [3287.3287] INFO ProtocolHandler: [0xb30620]: Need to send state update Feb 07 10:08:01 volumio qobuz-connect[3287]: 20260207 10:08:01.985 [3287.3287] INFO QConnectMessageSender: [0xc295d0]: Sending StateUpdated message Feb 07 10:08:01 volumio qobuz-connect[3287]: 20260207 10:08:01.985 [3287.3287] INFO QwspMessageSender: [0xc77b00]: Sending Payload message Feb 07 10:08:01 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:01 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:08:01 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:08:01 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:08:01 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:08:01 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:08:01 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:08:01 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:11 volumio qobuz-connect[3287]: 20260207 10:08:11.985 [3287.3287] INFO ProtocolHandler: [0xb30620]: Need to send state update Feb 07 10:08:11 volumio qobuz-connect[3287]: 20260207 10:08:11.985 [3287.3287] INFO QConnectMessageSender: [0xc295d0]: Sending StateUpdated message Feb 07 10:08:11 volumio qobuz-connect[3287]: 20260207 10:08:11.985 [3287.3287] INFO QwspMessageSender: [0xc77b00]: Sending Payload message Feb 07 10:08:11 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:11 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:08:11 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:08:11 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:08:11 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:08:11 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:08:11 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:08:11 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.045 [3287.3287] INFO AudioStreamManager: [0xb2ffc8]: [Stream 6]: Running audio stream Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.045 [3287.3287] INFO UrlAudioSource: [0xb94d90]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=9773246&eid=10474468&fmt=7&profile=raw&app_id=174516466&cid=3724266&etsp=1770458692&hmac=XXcVm2eCn3ME2L3C-ac3FmVBUDo Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.045 [3287.3287] INFO ContentFetcher: [0xd13a70]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=9773246&eid=10474468&fmt=7&profile=raw&app_id=174516466&cid=3724266&etsp=1770458692&hmac=XXcVm2eCn3ME2L3C-ac3FmVBUDo, offset: 0 Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.057 [3287.3287] INFO SampleApp: [Stream 6]: New audio stream (starting from 0ms) Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.058 [3287.3287] INFO SampleApp: [Stream 6]: Stream metadata became available: Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.058 [3287.3287] INFO SampleApp: Title: Last Night I Dreamt That Somebody Loved Me (2011 Remaster) Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.058 [3287.3287] INFO SampleApp: Artist: The Smiths Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.058 [3287.3287] INFO SampleApp: Album: Strangeways, Here We Come (2011 Remaster) Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.058 [3287.3287] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/43/35/0825646443543_600.jpg Feb 07 10:08:18 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.517 [3287.3287] INFO UrlAudioSource: [0xb94d90]: Content info extracted Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.517 [3287.3287] INFO UrlAudioSource: [0xb94d90]: Size: 115931841 Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.517 [3287.8269] INFO AudioDecoder: [0xd27dd0]: Stream info: Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.517 [3287.8269] INFO AudioDecoder: [0xd27dd0]: Total samples: 29379840 Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.517 [3287.8269] INFO AudioDecoder: [0xd27dd0]: Sample rate: 96000 Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.518 [3287.8269] INFO AudioDecoder: [0xd27dd0]: Channel count: 2 Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.518 [3287.8269] INFO AudioDecoder: [0xd27dd0]: Bits per sample: 24 Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.518 [3287.8269] INFO AudioDecoder: [0xd27dd0]: Duration: 306040 Feb 07 10:08:18 volumio qobuz-connect[3287]: 20260207 10:08:18.518 [3287.3287] INFO UrlAudioSource: [0xb94d90]: Audio properties have changed Feb 07 10:08:21 volumio qobuz-connect[3287]: 20260207 10:08:21.985 [3287.3287] INFO ProtocolHandler: [0xb30620]: Need to send state update Feb 07 10:08:21 volumio qobuz-connect[3287]: 20260207 10:08:21.985 [3287.3287] INFO QConnectMessageSender: [0xc295d0]: Sending StateUpdated message Feb 07 10:08:21 volumio qobuz-connect[3287]: 20260207 10:08:21.985 [3287.3287] INFO QwspMessageSender: [0xc77b00]: Sending Payload message Feb 07 10:08:21 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:21 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:08:21 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:08:21 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:08:21 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:08:21 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:08:21 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:08:21 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:27 volumio qobuz-connect[3287]: 20260207 10:08:27.386 [3287.3287] INFO AudioStreamManager: [0xb2ffc8]: [Stream 5]: Audio stream has finished Feb 07 10:08:27 volumio qobuz-connect[3287]: 20260207 10:08:27.386 [3287.3287] INFO SampleApp: [Stream 5]: Audio stream finished Feb 07 10:08:27 volumio qobuz-connect[3287]: 20260207 10:08:27.386 [3287.3287] INFO SampleApp: Playback is nearly finished Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.043 [3287.3287] INFO SampleApp: Playback has finished Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.043 [3287.3287] INFO AudioStreamManager: [0xb2ffc8]: [Stream 5]: Disposing of audio stream Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.043 [3287.3287] INFO ContentFetcher: [0xbfc158]: Canceling download Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.044 [3287.3287] INFO SampleApp: [Stream 5]: Audio stream has been disposed of Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.044 [3287.3287] INFO StreamingEventReporter: [0xb30a38]: Reporting streaming ended event Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.044 [3287.3287] INFO HttpDownloader: [0xb30a90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.044 [3287.3287] INFO ProtocolHandler: [0xb30620]: Need to send state update Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.044 [3287.3287] INFO QConnectMessageSender: [0xc295d0]: Sending StateUpdated message Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.044 [3287.3287] INFO QwspMessageSender: [0xc77b00]: Sending Payload message Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:08:28 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.046 [3287.3287] INFO ProtocolHandler: [0xb30620]: Need to send state update Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.046 [3287.3287] INFO QConnectMessageSender: [0xc295d0]: Sending StateUpdated message Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.046 [3287.3287] INFO QwspMessageSender: [0xc77b00]: Sending Payload message Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.046 [3287.3287] INFO QConnectMessageSender: [0xc295d0]: Sending FileAudioQualityChanged message Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.047 [3287.3287] INFO QwspMessageSender: [0xc77b00]: Sending Payload message Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.047 [3287.3287] INFO StreamingEventReporter: [0xb30a38]: Reporting streaming started event Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.047 [3287.3287] INFO ProtocolHandler: [0xb30620]: Need to send state update Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.047 [3287.3287] INFO QConnectMessageSender: [0xc295d0]: Sending StateUpdated message Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.048 [3287.3287] INFO QwspMessageSender: [0xc77b00]: Sending Payload message Feb 07 10:08:28 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:08:28 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:08:28 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:08:28 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:08:28 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:08:28 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:08:28 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:08:28 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:08:28 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:08:28 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:08:28 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:08:28 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:08:28 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:08:28 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:08:28 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.202 [3287.3287] INFO ProtocolHandler: [0xb30620]: Received SetState message: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.202 [3287.3287] INFO ProtocolHandler: [0xb30620]: Playing state: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.202 [3287.3287] INFO ProtocolHandler: [0xb30620]: Playback position: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.202 [3287.3287] INFO ProtocolHandler: [0xb30620]: Queue version: 1.2 Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.202 [3287.3287] INFO ProtocolHandler: [0xb30620]: Current track: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.202 [3287.3287] INFO ProtocolHandler: [0xb30620]: Next track: TID: 10474469, QID: 6, Context UUID: 20e9b6db-0598-4681-9643-33ac0e439f57 Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.202 [3287.3287] INFO MediaEngine: [0xb2fee0]: Setting next track: 10474469 Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.202 [3287.3287] INFO AudioStreamManager: [0xb2ffc8]: New stream: 7 Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.202 [3287.3287] INFO HttpDownloader: [0xb80660]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=eedb4e0290af340b3ca81ce39680fb98&request_ts=1770455308&track_id=10474469 Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.202 [3287.3287] INFO HttpDownloader: [0xede000]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=10474469 Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO HttpDownloader: [0xe82040]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=5a1cd8159b8e1c91aab73dbe8c73b5b8&request_ts=1770455308&track_id=10474469 Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO ProtocolHandler: [0xb30620]: Received SetState message: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO ProtocolHandler: [0xb30620]: Playing state: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO ProtocolHandler: [0xb30620]: Playback position: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO ProtocolHandler: [0xb30620]: Queue version: 1.2 Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO ProtocolHandler: [0xb30620]: Current track: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO ProtocolHandler: [0xb30620]: Next track: TID: 10474469, QID: 6, Context UUID: 20e9b6db-0598-4681-9643-33ac0e439f57 Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO ProtocolHandler: [0xb30620]: Received SetState message: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO ProtocolHandler: [0xb30620]: Playing state: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO ProtocolHandler: [0xb30620]: Playback position: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO ProtocolHandler: [0xb30620]: Queue version: 1.2 Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO ProtocolHandler: [0xb30620]: Current track: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.203 [3287.3287] INFO ProtocolHandler: [0xb30620]: Next track: TID: 10474469, QID: 6, Context UUID: 20e9b6db-0598-4681-9643-33ac0e439f57 Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.311 [3287.3287] INFO AudioStreamManager: [0xb2ffc8]: [Stream 7]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=9773246&eid=10474469&fmt=7&profile=raw&app_id=174516466&cid=3724266&etsp=1770458908&hmac=0dBIxkJf5QhDJ4e4IT9tOKzEAEU Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.347 [3287.3287] INFO AudioStreamManager: [0xb2ffc8]: [Stream 7]: Metadata became available: Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.348 [3287.3287] INFO AudioStreamManager: [0xb2ffc8]: Title: Unhappy Birthday (2011 Remaster) Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.348 [3287.3287] INFO AudioStreamManager: [0xb2ffc8]: Artist: The Smiths Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.348 [3287.3287] INFO AudioStreamManager: [0xb2ffc8]: Album: Strangeways, Here We Come (2011 Remaster) Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.348 [3287.3287] INFO AudioStreamManager: [0xb2ffc8]: Album art URL: https://static.qobuz.com/images/covers/43/35/0825646443543_600.jpg Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.382 [3287.3287] INFO AudioStreamManager: [0xb2ffc8]: [Stream 7]: stream information have been fetched Feb 07 10:08:28 volumio qobuz-connect[3287]: 20260207 10:08:28.632 [3287.3287] INFO HttpDownloader: [0xb30a90]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Feb 07 10:08:38 volumio qobuz-connect[3287]: 20260207 10:08:38.047 [3287.3287] INFO ProtocolHandler: [0xb30620]: Need to send state update Feb 07 10:08:38 volumio qobuz-connect[3287]: 20260207 10:08:38.047 [3287.3287] INFO QConnectMessageSender: [0xc295d0]: Sending StateUpdated message Feb 07 10:08:38 volumio qobuz-connect[3287]: 20260207 10:08:38.047 [3287.3287] INFO QwspMessageSender: [0xc77b00]: Sending Payload message Feb 07 10:08:38 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:38 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:08:38 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:08:38 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:08:38 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:08:38 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:08:38 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:08:38 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:48 volumio qobuz-connect[3287]: 20260207 10:08:48.048 [3287.3287] INFO ProtocolHandler: [0xb30620]: Need to send state update Feb 07 10:08:48 volumio qobuz-connect[3287]: 20260207 10:08:48.048 [3287.3287] INFO QConnectMessageSender: [0xc295d0]: Sending StateUpdated message Feb 07 10:08:48 volumio qobuz-connect[3287]: 20260207 10:08:48.048 [3287.3287] INFO QwspMessageSender: [0xc77b00]: Sending Payload message Feb 07 10:08:48 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:48 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:08:48 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:08:48 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:08:48 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:08:48 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:08:48 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:08:48 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:50 volumio volumio[2717]: verbose: New Socket.io Connection to 192.168.1.129:3000 from 192.168.1.173 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Feb 07 10:08:50 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 10:08:50 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 10:08:50 volumio volumio[2717]: info: Discovery: Getting this device information Feb 07 10:08:50 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:50 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 10:08:51 volumio volumio[2717]: info: Discovery: Getting this device information Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Feb 07 10:08:51 volumio sudo[8340]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 07 10:08:51 volumio sudo[8358]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 10:08:51 volumio sudo[8351]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 07 10:08:51 volumio sudo[8358]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 07 10:08:51 volumio sudo[8351]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 07 10:08:51 volumio sudo[8336]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Feb 07 10:08:51 volumio sudo[8336]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 07 10:08:51 volumio sudo[8340]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 07 10:08:51 volumio sudo[8358]: pam_unix(sudo:session): session closed for user root Feb 07 10:08:51 volumio sudo[8356]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 10:08:51 volumio sudo[8347]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 07 10:08:51 volumio sudo[8347]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 07 10:08:51 volumio sudo[8356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 07 10:08:51 volumio sudo[8340]: pam_unix(sudo:session): session closed for user root Feb 07 10:08:51 volumio sudo[8351]: pam_unix(sudo:session): session closed for user root Feb 07 10:08:51 volumio sudo[8347]: pam_unix(sudo:session): session closed for user root Feb 07 10:08:51 volumio sudo[8356]: pam_unix(sudo:session): session closed for user root Feb 07 10:08:51 volumio sudo[8336]: pam_unix(sudo:session): session closed for user root Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 10:08:51 volumio volumio[2717]: info: Discovery: Getting this device information Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 10:08:51 volumio volumio[2717]: info: Discovery: Getting this device information Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 10:08:51 volumio volumio[2717]: verbose: New Socket.io Connection to 192.168.1.129:3000 from 192.168.1.173 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 07 10:08:51 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 07 10:08:52 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 10:08:52 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 10:08:52 volumio volumio[2717]: info: Discovery: Getting this device information Feb 07 10:08:52 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:52 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 10:08:52 volumio volumio[2717]: verbose: New Socket.io Connection to 192.168.1.129:3000 from 192.168.1.173 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Feb 07 10:08:52 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 07 10:08:52 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 07 10:08:52 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 10:08:52 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 10:08:52 volumio volumio[2717]: info: Discovery: Getting this device information Feb 07 10:08:52 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:52 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 10:08:52 volumio volumio[2717]: verbose: New Socket.io Connection to 192.168.1.129:3000 from 192.168.1.173 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Feb 07 10:08:52 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 07 10:08:52 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 07 10:08:53 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 07 10:08:53 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 07 10:08:54 volumio sudo[8368]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 10:08:54 volumio sudo[8368]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 07 10:08:54 volumio sudo[8368]: pam_unix(sudo:session): session closed for user root Feb 07 10:08:54 volumio sudo[8370]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 10:08:54 volumio sudo[8370]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 07 10:08:54 volumio sudo[8370]: pam_unix(sudo:session): session closed for user root Feb 07 10:08:54 volumio volumio[2717]: verbose: New Socket.io Connection to 192.168.1.129 from 192.168.1.173 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Feb 07 10:08:54 volumio sudo[8388]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 10:08:54 volumio sudo[8388]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 07 10:08:54 volumio sudo[8388]: pam_unix(sudo:session): session closed for user root Feb 07 10:08:54 volumio sudo[8390]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 10:08:54 volumio sudo[8390]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 07 10:08:54 volumio sudo[8390]: pam_unix(sudo:session): session closed for user root Feb 07 10:08:54 volumio volumio[2717]: verbose: New Socket.io Connection to 192.168.1.129 from 192.168.1.173 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Feb 07 10:08:54 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:54 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 07 10:08:54 volumio volumio[2717]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 07 10:08:54 volumio volumio[2717]: info: Listing playlists Feb 07 10:08:54 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 07 10:08:54 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 07 10:08:54 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 07 10:08:54 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 07 10:08:58 volumio qobuz-connect[3287]: 20260207 10:08:58.049 [3287.3287] INFO ProtocolHandler: [0xb30620]: Need to send state update Feb 07 10:08:58 volumio qobuz-connect[3287]: 20260207 10:08:58.049 [3287.3287] INFO QConnectMessageSender: [0xc295d0]: Sending StateUpdated message Feb 07 10:08:58 volumio qobuz-connect[3287]: 20260207 10:08:58.049 [3287.3287] INFO QwspMessageSender: [0xc77b00]: Sending Payload message Feb 07 10:08:58 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:08:58 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:08:58 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:08:58 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:08:58 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:08:58 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:08:58 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:08:58 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:09:08 volumio qobuz-connect[3287]: 20260207 10:09:08.049 [3287.3287] INFO ProtocolHandler: [0xb30620]: Need to send state update Feb 07 10:09:08 volumio qobuz-connect[3287]: 20260207 10:09:08.049 [3287.3287] INFO QConnectMessageSender: [0xc295d0]: Sending StateUpdated message Feb 07 10:09:08 volumio qobuz-connect[3287]: 20260207 10:09:08.049 [3287.3287] INFO QwspMessageSender: [0xc77b00]: Sending Payload message Feb 07 10:09:08 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:09:08 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:09:08 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:09:08 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:09:08 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:09:08 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:09:08 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:09:08 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:09:13 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 07 10:09:13 volumio volumio[2717]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 07 10:09:13 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 07 10:09:13 volumio volumio[2717]: info: Received Get System Version Feb 07 10:09:13 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 10:09:13 volumio volumio[2717]: info: Received Get System Info Feb 07 10:09:13 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 07 10:09:13 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 07 10:09:13 volumio volumio[2717]: info: Discovery: Getting this device information Feb 07 10:09:13 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:09:13 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 07 10:09:18 volumio qobuz-connect[3287]: 20260207 10:09:18.049 [3287.3287] INFO ProtocolHandler: [0xb30620]: Need to send state update Feb 07 10:09:18 volumio qobuz-connect[3287]: 20260207 10:09:18.049 [3287.3287] INFO QConnectMessageSender: [0xc295d0]: Sending StateUpdated message Feb 07 10:09:18 volumio qobuz-connect[3287]: 20260207 10:09:18.049 [3287.3287] INFO QwspMessageSender: [0xc77b00]: Sending Payload message Feb 07 10:09:18 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:09:18 volumio volumio[2717]: info: CoreCommandRouter::servicePushState Feb 07 10:09:18 volumio volumio[2717]: info: CoreStateMachine::pushState Feb 07 10:09:18 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 10:09:18 volumio volumio[2717]: info: CoreCommandRouter::volumioPushState Feb 07 10:09:18 volumio volumio[2717]: info: MRS: Pushing multiroomSync output update for this device Feb 07 10:09:18 volumio volumio[2717]: info: MRS: Pushing multiroomSync output Feb 07 10:09:18 volumio volumio[2717]: info: CoreCommandRouter::volumioGetState Feb 07 10:09:21 volumio volumio[2717]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Feb 07 10:09:21 volumio volumio[2717]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Feb 07 10:09:21 volumio volumio[2717]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 10:09:21 volumio volumio[2717]: TypeError: Cannot read properties of undefined (reading 'then') Feb 07 10:09:21 volumio volumio[2717]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Feb 07 10:09:21 volumio volumio[2717]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30) Feb 07 10:09:21 volumio volumio[2717]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1467:26) Feb 07 10:09:21 volumio volumio[2717]: at Socket.emit (node:events:514:28) Feb 07 10:09:21 volumio volumio[2717]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Feb 07 10:09:21 volumio volumio[2717]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Feb 07 10:09:21 volumio volumio[2717]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 10:09:23 volumio sudo[8451]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-07 10:08' Feb 07 10:09:23 volumio sudo[8451]: 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"