-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Sat 2025-06-21 22:37:53 GMT. -- Jun 21 22:36:01 volumio qobuz-connect[1322]: 20250621 22:36:01.589 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:36:01 volumio qobuz-connect[1322]: 20250621 22:36:01.589 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:36:01 volumio qobuz-connect[1322]: 20250621 22:36:01.589 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:36:01 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:36:01 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:36:01 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:36:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:36:01 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:36:01 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:36:11 volumio qobuz-connect[1322]: 20250621 22:36:11.589 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:36:11 volumio qobuz-connect[1322]: 20250621 22:36:11.589 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:36:11 volumio qobuz-connect[1322]: 20250621 22:36:11.589 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:36:11 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:36:11 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:36:11 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:36:11 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:36:11 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:36:11 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:36:21 volumio qobuz-connect[1322]: 20250621 22:36:21.589 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:36:21 volumio qobuz-connect[1322]: 20250621 22:36:21.589 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:36:21 volumio qobuz-connect[1322]: 20250621 22:36:21.589 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:36:21 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:36:21 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:36:21 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:36:21 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:36:21 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:36:21 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:36:24 volumio ntpd[792]: 83.137.225.123 local addr 192.168.1.194 -> Jun 21 22:36:25 volumio ntpd[792]: 95.131.83.40 local addr 192.168.1.194 -> Jun 21 22:36:31 volumio qobuz-connect[1322]: 20250621 22:36:31.589 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:36:31 volumio qobuz-connect[1322]: 20250621 22:36:31.589 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:36:31 volumio qobuz-connect[1322]: 20250621 22:36:31.589 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:36:31 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:36:31 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:36:31 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:36:31 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:36:31 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:36:31 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:36:41 volumio qobuz-connect[1322]: 20250621 22:36:41.589 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:36:41 volumio qobuz-connect[1322]: 20250621 22:36:41.589 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:36:41 volumio qobuz-connect[1322]: 20250621 22:36:41.589 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:36:41 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:36:41 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:36:41 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:36:41 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:36:41 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:36:41 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:36:51 volumio qobuz-connect[1322]: 20250621 22:36:51.589 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:36:51 volumio qobuz-connect[1322]: 20250621 22:36:51.589 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:36:51 volumio qobuz-connect[1322]: 20250621 22:36:51.589 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:36:51 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:36:51 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:36:51 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:36:51 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:36:51 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:36:51 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:01 volumio qobuz-connect[1322]: 20250621 22:37:01.589 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:37:01 volumio qobuz-connect[1322]: 20250621 22:37:01.589 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:37:01 volumio qobuz-connect[1322]: 20250621 22:37:01.589 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:37:01 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:01 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:01 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:01 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:37:01 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:01 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:11 volumio qobuz-connect[1322]: 20250621 22:37:11.589 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:37:11 volumio qobuz-connect[1322]: 20250621 22:37:11.589 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:37:11 volumio qobuz-connect[1322]: 20250621 22:37:11.589 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:37:11 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:11 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:11 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:11 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:37:11 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:11 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:21 volumio qobuz-connect[1322]: 20250621 22:37:21.589 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:37:21 volumio qobuz-connect[1322]: 20250621 22:37:21.589 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:37:21 volumio qobuz-connect[1322]: 20250621 22:37:21.589 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:37:21 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:21 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:21 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:21 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:37:21 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:21 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.825 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 5]: Running audio stream Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.825 [1322.1322] INFO UrlAudioSource: [0x15f44c0]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=320645720&fmt=7&profile=raw&app_id=174516466&cid=2814091&etsp=1750548781&hmac=xBaV0FhdC7ECVZzJB1sBdVxJDXY Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.825 [1322.1322] INFO ContentFetcher: [0x15f43c0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=320645720&fmt=7&profile=raw&app_id=174516466&cid=2814091&etsp=1750548781&hmac=xBaV0FhdC7ECVZzJB1sBdVxJDXY, offset: 0 Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.837 [1322.1322] INFO SampleApp: [Stream 5]: New audio stream (starting from 0ms) Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.838 [1322.1322] INFO SampleApp: [Stream 5]: Stream metadata became available: Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.838 [1322.1322] INFO SampleApp: Title: The Black Dog and the Wandering Boy Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.838 [1322.1322] INFO SampleApp: Artist: James McMurtry Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.838 [1322.1322] INFO SampleApp: Album: The Black Dog and the Wandering Boy Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.838 [1322.1322] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/gc/5z/c9lzah11n5zgc_600.jpg Jun 21 22:37:27 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.945 [1322.1322] INFO UrlAudioSource: [0x15f44c0]: Content info extracted Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.945 [1322.1322] INFO UrlAudioSource: [0x15f44c0]: Size: 104421562 Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.946 [1322.3808] INFO AudioDecoder: [0x146bc10]: Stream info: Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.947 [1322.3808] INFO AudioDecoder: [0x146bc10]: Total samples: 26874880 Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.947 [1322.3808] INFO AudioDecoder: [0x146bc10]: Sample rate: 96000 Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.947 [1322.3808] INFO AudioDecoder: [0x146bc10]: Channel count: 2 Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.947 [1322.3808] INFO AudioDecoder: [0x146bc10]: Bits per sample: 24 Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.947 [1322.3808] INFO AudioDecoder: [0x146bc10]: Duration: 279946 Jun 21 22:37:27 volumio qobuz-connect[1322]: 20250621 22:37:27.948 [1322.1322] INFO UrlAudioSource: [0x15f44c0]: Audio properties have changed Jun 21 22:37:31 volumio qobuz-connect[1322]: 20250621 22:37:31.589 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:37:31 volumio qobuz-connect[1322]: 20250621 22:37:31.589 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:37:31 volumio qobuz-connect[1322]: 20250621 22:37:31.589 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:37:31 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:31 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:31 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:31 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:37:31 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:31 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.171 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 4]: Audio stream has finished Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.172 [1322.1322] INFO SampleApp: [Stream 4]: Audio stream finished Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.172 [1322.1322] INFO SampleApp: Playback is nearly finished Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.825 [1322.1322] INFO SampleApp: Playback has finished Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.825 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 4]: Disposing of audio stream Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.825 [1322.1322] INFO ContentFetcher: [0x160d520]: Canceling download Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.825 [1322.1322] INFO SampleApp: [Stream 4]: Audio stream has been disposed of Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.825 [1322.1322] INFO StreamingEventReporter: [0x1297970]: Reporting streaming ended event Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.826 [1322.1322] INFO HttpDownloader: [0x12979c8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.826 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.826 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.826 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.827 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending FileAudioQualityChanged message Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.827 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.827 [1322.1322] INFO StreamingEventReporter: [0x1297970]: Reporting streaming started event Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:37 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:37 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:37 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:37 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:37 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:37 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:37 volumio volumio[831]: info: [LastFM] Current track has sufficient metadata: title (The Black Dog and the Wandering Boy) and artist (James McMurtry) passed on explicitly Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.936 [1322.1322] INFO ProtocolHandler: [0x1297558]: Received SetState message: Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.937 [1322.1322] INFO ProtocolHandler: [0x1297558]: Playing state: Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.937 [1322.1322] INFO ProtocolHandler: [0x1297558]: Playback position: Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.937 [1322.1322] INFO ProtocolHandler: [0x1297558]: Queue version: 3.1 Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.937 [1322.1322] INFO ProtocolHandler: [0x1297558]: Current track: Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.937 [1322.1322] INFO ProtocolHandler: [0x1297558]: Next track: TID: 320645721, QID: 6, Context UUID: 6c22ba41-43e1-4bcd-8b42-c20b15ae0e36 Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.938 [1322.1322] INFO MediaEngine: [0x1296e18]: Setting next track: 320645721 Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.938 [1322.1322] INFO AudioStreamManager: [0x1296f00]: New stream: 6 Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.938 [1322.1322] INFO HttpDownloader: [0x1314508]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=6590828bea2260571ade4b53484cf2fe&request_ts=1750545457&track_id=320645721 Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.938 [1322.1322] INFO HttpDownloader: [0x15fe5d8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=320645721 Jun 21 22:37:37 volumio qobuz-connect[1322]: 20250621 22:37:37.938 [1322.1322] INFO HttpDownloader: [0x147d1f0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=7f15aca4f6801a3327a126dcf5871af7&request_ts=1750545457&track_id=320645721 Jun 21 22:37:38 volumio qobuz-connect[1322]: 20250621 22:37:38.016 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 6]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=320645721&fmt=7&profile=raw&app_id=174516466&cid=2814091&etsp=1750549057&hmac=14BrSEVKqasfzhjfH2cdVDaDXr0 Jun 21 22:37:38 volumio qobuz-connect[1322]: 20250621 22:37:38.053 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 6]: stream information have been fetched Jun 21 22:37:38 volumio qobuz-connect[1322]: 20250621 22:37:38.077 [1322.1322] INFO HttpDownloader: [0x12979c8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jun 21 22:37:38 volumio qobuz-connect[1322]: 20250621 22:37:38.094 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 6]: Metadata became available: Jun 21 22:37:38 volumio qobuz-connect[1322]: 20250621 22:37:38.094 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Title: Back to Coeur d’Alene Jun 21 22:37:38 volumio qobuz-connect[1322]: 20250621 22:37:38.094 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Artist: James McMurtry Jun 21 22:37:38 volumio qobuz-connect[1322]: 20250621 22:37:38.094 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Album: The Black Dog and the Wandering Boy Jun 21 22:37:38 volumio qobuz-connect[1322]: 20250621 22:37:38.094 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Album art URL: https://static.qobuz.com/images/covers/gc/5z/c9lzah11n5zgc_600.jpg Jun 21 22:37:38 volumio volumio[831]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"The Black Dog and the Wandering Boy","url":"https://www.last.fm/music/James+McMurtry/_/The+Black+Dog+and+the+Wandering+Boy","duration":"0","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"730","playcount":"1579","artist":{"name":"James McMurtry","mbid":"0d842c11-3f11-4dae-aa41-4e6e8beccc09","url":"https://www.last.fm/music/James+McMurtry"},"album":{"artist":"James McMurtry","title":"The Black Dog and the Wandering Boy [Explicit]","url":"https://www.last.fm/music/James+McMurtry/The+Black+Dog+and+the+Wandering+Boy+%5BExplicit%5D","image":[{"#":"https://lastfm.freetls.fastly.net/i/u/34s/79fd79869fd0622040d5e484a5eb2f9d.png","@":{"size":"small"}},{"#":"https://lastfm.freetls.fastly.net/i/u/64s/79fd79869fd0622040d5e484a5eb2f9d.png","@":{"size":"medium"}},{"#":"https://lastfm.freetls.fastly.net/i/u/174s/79fd79869fd0622040d5e484a5eb2f9d.png","@":{"size":"large"}},{"#":"https://lastfm.freetls.fastly.net/i/u/300x300/79fd79869fd0622040d5e484a5eb2f9d.png","@":{"size":"extralarge"}}]},"userplaycount":"3","userloved":"0","toptags":{"tag":[{"name":"americana","url":"https://www.last.fm/tag/americana"},{"name":"Alt-country","url":"https://www.last.fm/tag/Alt-country"},{"name":"roots rock","url":"https://www.last.fm/tag/roots+rock"},{"name":"2020s","url":"https://www.last.fm/tag/2020s"}]}}} Jun 21 22:37:47 volumio qobuz-connect[1322]: 20250621 22:37:47.826 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:37:47 volumio qobuz-connect[1322]: 20250621 22:37:47.826 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:37:47 volumio qobuz-connect[1322]: 20250621 22:37:47.826 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:37:47 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:47 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:47 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:47 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:37:47 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:47 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.536 [1322.1322] INFO ProtocolHandler: [0x1297558]: Received SetState message: Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.536 [1322.1322] INFO ProtocolHandler: [0x1297558]: Playing state: Playing Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.536 [1322.1322] INFO ProtocolHandler: [0x1297558]: Playback position: 0 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.536 [1322.1322] INFO ProtocolHandler: [0x1297558]: Queue version: 4.1 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.536 [1322.1322] INFO ProtocolHandler: [0x1297558]: Current track: TID: 7395, QID: 0, Context UUID: 64648e5a-628d-4a4b-951a-d7dbc2055a14 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.537 [1322.1322] INFO ProtocolHandler: [0x1297558]: Next track: TID: 7396, QID: 1, Context UUID: 64648e5a-628d-4a4b-951a-d7dbc2055a14 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.537 [1322.1322] INFO MediaEngine: [0x1296e18]: Stopping playback, clearing tracks Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.537 [1322.1322] INFO MediaEngine: [0x1296e18]: Initiating playback Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.537 [1322.1322] INFO AudioRenderer: [0x1297038]: Stopping audio renderer Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.537 [1322.1322] INFO SampleApp: Stopping playback Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.537 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Clearing all streams Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.537 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 5]: Disposing of audio stream Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.538 [1322.1322] INFO ContentFetcher: [0x15f43c0]: Canceling download Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.546 [1322.1322] INFO SampleApp: Playback state changed: Stopped Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.546 [1322.1322] INFO StreamingEventReporter: [0x1297970]: Reporting streaming ended event Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.546 [1322.1322] INFO HttpDownloader: [0x12979c8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.547 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.547 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.547 [1322.1322] INFO SampleApp: [Stream 5]: Audio stream has been disposed of Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.547 [1322.1322] INFO MediaEngine: [0x1296e18]: Setting current track: 7395, initial offset: 0ms Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.547 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Clearing all streams Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.547 [1322.1322] INFO AudioStreamManager: [0x1296f00]: New stream: 7 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.547 [1322.1322] INFO HttpDownloader: [0x1694378]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=1184648bce9eec95c82da6c9fda9341c&request_ts=1750545472&track_id=7395 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.547 [1322.1322] INFO HttpDownloader: [0x144a358]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=7395 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.547 [1322.1322] INFO HttpDownloader: [0x12c2818]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=f8e47a37731fa739860ef39eb309ba2a&request_ts=1750545472&track_id=7395 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.548 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 7]: Running audio stream Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.548 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:37:52 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.550 [1322.1322] INFO MediaEngine: [0x1296e18]: Setting next track: 7396 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.551 [1322.1322] INFO AudioStreamManager: [0x1296f00]: New stream: 8 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.551 [1322.1322] INFO HttpDownloader: [0x16003a8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=bf364d5688621f3743bdc5eea854f7b0&request_ts=1750545472&track_id=7396 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.551 [1322.1322] INFO HttpDownloader: [0x1322848]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=7396 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.551 [1322.1322] INFO HttpDownloader: [0x1355f18]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=09fcc0842c7b8455b131f9be4b764976&request_ts=1750545472&track_id=7396 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.553 [1322.1322] INFO MediaEngine: [0x1296e18]: Waiting for current stream to start before starting audio renderer Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:52 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.628 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 7]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=7395&fmt=27&profile=raw&app_id=174516466&cid=2814091&etsp=1750549072&hmac=-P8tCYXugFFADDnEPlrgytI_9Fg Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.644 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 8]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=7396&fmt=27&profile=raw&app_id=174516466&cid=2814091&etsp=1750549072&hmac=dYaQH1oZGu_gnz_PYMoeLwMjw7g Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.673 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 8]: stream information have been fetched Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.679 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 7]: stream information have been fetched Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.679 [1322.1322] INFO UrlAudioSource: [0x1797ad0]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=7395&fmt=27&profile=raw&app_id=174516466&cid=2814091&etsp=1750549072&hmac=-P8tCYXugFFADDnEPlrgytI_9Fg Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.680 [1322.1322] INFO ContentFetcher: [0x13307b0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=5005241&eid=7395&fmt=27&profile=raw&app_id=174516466&cid=2814091&etsp=1750549072&hmac=-P8tCYXugFFADDnEPlrgytI_9Fg, offset: 0 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.680 [1322.1322] INFO AudioRenderer: [0x1297038]: Starting audio renderer, initial playback state: Playing Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.680 [1322.1322] INFO SampleApp: [Stream 7]: New audio stream (starting from 0ms) Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: QobuzConnect: alread currrent service, send playback confirmation Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.682 [1322.1322] INFO SampleApp: Initiating playback, initial state: Playing Jun 21 22:37:52 volumio volumio[831]: info: FusionDsp - ---- read samplerate, raw: 176400,S32_LE,2,32 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.693 [1322.1322] INFO SampleApp: Playback state changed: Playing Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.693 [1322.1322] INFO StreamingEventReporter: [0x1297970]: Reporting streaming started event Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.693 [1322.1322] INFO ProtocolHandler: [0x1297558]: Need to send state update Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.693 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending StateUpdated message Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.693 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.694 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending FileAudioQualityChanged message Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.694 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:37:52 volumio volumio[831]: info: FusionDsp - ---- read samplerate from file: 176400 Jun 21 22:37:52 volumio volumio[831]: info: camilladsp stopping service pid 1415... Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.694 [1322.1322] INFO QConnectMessageSender: [0x12d7000]: Sending DeviceAudioQualityChanged message Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.695 [1322.1322] INFO QwspMessageSender: [0x139fee8]: Sending Payload message Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.695 [1322.1322] INFO HttpDownloader: [0x12979c8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.712 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 8]: Metadata became available: Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.712 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Title: Baby Be Mine (Album Version) Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.712 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Artist: Michael Jackson Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.712 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Album: Thriller (Album Version) Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.712 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Album art URL: https://static.qobuz.com/images/covers/24/12/0074643811224_600.jpg Jun 21 22:37:52 volumio volumio[831]: info: camilladsp service terminated, instance 1 Jun 21 22:37:52 volumio volumio[831]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 21 22:37:52 volumio volumio[831]: info: camilladsp service started and running in background, instance 1 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.723 [1322.1322] INFO UrlAudioSource: [0x1797ad0]: Content info extracted Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.723 [1322.1322] INFO UrlAudioSource: [0x1797ad0]: Size: 274190908 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.724 [1322.3862] INFO AudioDecoder: [0x1412e18]: Stream info: Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.724 [1322.3862] INFO AudioDecoder: [0x1412e18]: Total samples: 64103760 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.724 [1322.3862] INFO AudioDecoder: [0x1412e18]: Sample rate: 176400 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.724 [1322.3862] INFO AudioDecoder: [0x1412e18]: Channel count: 2 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.724 [1322.3862] INFO AudioDecoder: [0x1412e18]: Bits per sample: 24 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.724 [1322.3862] INFO AudioDecoder: [0x1412e18]: Duration: 363400 Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.725 [1322.1322] INFO UrlAudioSource: [0x1797ad0]: Audio properties have changed Jun 21 22:37:52 volumio volumio[831]: info: FusionDsp - ---- read samplerate, raw: 176400,S32_LE,2,32 Jun 21 22:37:52 volumio volumio[831]: info: FusionDsp - ---- read samplerate from file: 176400 Jun 21 22:37:52 volumio volumio[831]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.726 [1322.1322] INFO AudioStreamManager: [0x1296f00]: [Stream 7]: Metadata became available: Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.726 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Title: Wanna Be Startin' Somethin' (Album Version) Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.726 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Artist: Michael Jackson Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.726 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Album: Thriller (Album Version) Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.726 [1322.1322] INFO AudioStreamManager: [0x1296f00]: Album art URL: https://static.qobuz.com/images/covers/24/12/0074643811224_600.jpg Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.727 [1322.1322] INFO SampleApp: [Stream 7]: Stream metadata became available: Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.727 [1322.1322] INFO SampleApp: Title: Wanna Be Startin' Somethin' (Album Version) Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.727 [1322.1322] INFO SampleApp: Artist: Michael Jackson Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.727 [1322.1322] INFO SampleApp: Album: Thriller (Album Version) Jun 21 22:37:52 volumio qobuz-connect[1322]: 20250621 22:37:52.727 [1322.1322] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/24/12/0074643811224_600.jpg Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:52 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:52 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:52 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:52 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jun 21 22:37:52 volumio volumio[831]: info: CoreStateMachine::pushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jun 21 22:37:52 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jun 21 22:37:52 volumio volumio[831]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Jun 21 22:37:52 volumio volumio[831]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 22:37:52 volumio volumio[831]: TypeError: Cannot read property 'indexOf' of undefined Jun 21 22:37:52 volumio volumio[831]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) Jun 21 22:37:52 volumio volumio[831]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) Jun 21 22:37:52 volumio volumio[831]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) Jun 21 22:37:52 volumio volumio[831]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 21 22:37:52 volumio volumio[831]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) Jun 21 22:37:52 volumio volumio[831]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) Jun 21 22:37:52 volumio volumio[831]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 21 22:37:52 volumio volumio[831]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 21 22:37:52 volumio volumio[831]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) Jun 21 22:37:52 volumio volumio[831]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 21 22:37:52 volumio volumio[831]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Jun 21 22:37:52 volumio volumio[831]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) Jun 21 22:37:52 volumio volumio[831]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) Jun 21 22:37:52 volumio volumio[831]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Jun 21 22:37:52 volumio volumio[831]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Jun 21 22:37:52 volumio volumio[831]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) Jun 21 22:37:52 volumio volumio[831]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 22:37:53 volumio sudo[3872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-21 22:36 Jun 21 22:37:53 volumio sudo[3872]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="ac8237291e9f6fb802f0ead66c5a8bb83ed22e68" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 19 Jun 2025 05:10:54 PM CEST" VOLUMIO_VERSION="3.817" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d1fbccf832f6f49fc2a0b57fd64ae923"