-- Logs begin at Sat 2025-05-24 19:19:45 CEST, end at Sat 2025-05-24 20:07:01 CEST. -- May 24 20:06:04 volumio qobuz-connect[1912]: 20250524 20:06:04.652 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Need to send state update May 24 20:06:04 volumio qobuz-connect[1912]: 20250524 20:06:04.652 [1912.1912] INFO QConnectMessageSender: [0x556473c21960]: Sending StateUpdated message May 24 20:06:04 volumio qobuz-connect[1912]: 20250524 20:06:04.652 [1912.1912] INFO QwspMessageSender: [0x556473c21940]: Sending Payload message May 24 20:06:04 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:06:04 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:06:04 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:06:04 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 20:06:04 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:06:04 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:06:04 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:06:04 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:06:14 volumio qobuz-connect[1912]: 20250524 20:06:14.652 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Need to send state update May 24 20:06:14 volumio qobuz-connect[1912]: 20250524 20:06:14.652 [1912.1912] INFO QConnectMessageSender: [0x556473c21960]: Sending StateUpdated message May 24 20:06:14 volumio qobuz-connect[1912]: 20250524 20:06:14.652 [1912.1912] INFO QwspMessageSender: [0x556473c21940]: Sending Payload message May 24 20:06:14 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:06:14 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:06:14 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:06:14 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 20:06:14 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:06:14 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:06:14 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:06:14 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:06:24 volumio qobuz-connect[1912]: 20250524 20:06:24.652 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Need to send state update May 24 20:06:24 volumio qobuz-connect[1912]: 20250524 20:06:24.652 [1912.1912] INFO QConnectMessageSender: [0x556473c21960]: Sending StateUpdated message May 24 20:06:24 volumio qobuz-connect[1912]: 20250524 20:06:24.652 [1912.1912] INFO QwspMessageSender: [0x556473c21940]: Sending Payload message May 24 20:06:24 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:06:24 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:06:24 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:06:24 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 20:06:24 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:06:24 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:06:24 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:06:24 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:06:34 volumio qobuz-connect[1912]: 20250524 20:06:34.652 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Need to send state update May 24 20:06:34 volumio qobuz-connect[1912]: 20250524 20:06:34.652 [1912.1912] INFO QConnectMessageSender: [0x556473c21960]: Sending StateUpdated message May 24 20:06:34 volumio qobuz-connect[1912]: 20250524 20:06:34.652 [1912.1912] INFO QwspMessageSender: [0x556473c21940]: Sending Payload message May 24 20:06:34 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:06:34 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:06:34 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:06:34 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 20:06:34 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:06:34 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:06:34 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:06:34 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:06:44 volumio qobuz-connect[1912]: 20250524 20:06:44.652 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Need to send state update May 24 20:06:44 volumio qobuz-connect[1912]: 20250524 20:06:44.652 [1912.1912] INFO QConnectMessageSender: [0x556473c21960]: Sending StateUpdated message May 24 20:06:44 volumio qobuz-connect[1912]: 20250524 20:06:44.652 [1912.1912] INFO QwspMessageSender: [0x556473c21940]: Sending Payload message May 24 20:06:44 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:06:44 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:06:44 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:06:44 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 20:06:44 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:06:44 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:06:44 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:06:44 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:06:54 volumio qobuz-connect[1912]: 20250524 20:06:54.652 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Need to send state update May 24 20:06:54 volumio qobuz-connect[1912]: 20250524 20:06:54.652 [1912.1912] INFO QConnectMessageSender: [0x556473c21960]: Sending StateUpdated message May 24 20:06:54 volumio qobuz-connect[1912]: 20250524 20:06:54.652 [1912.1912] INFO QwspMessageSender: [0x556473c21940]: Sending Payload message May 24 20:06:54 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:06:54 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:06:54 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:06:54 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 20:06:54 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:06:54 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:06:54 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:06:54 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.939 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Received SetState message: May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.939 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Playing state: Playing May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.939 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Playback position: 0 May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.939 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Queue version: 42.1 May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.939 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Current track: TID: 335572303, QID: 0, Context UUID: 53c44484-e684-4b88-86fe-ef28d6fa690a May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.939 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Next track: TID: 335572304, QID: 1, Context UUID: 53c44484-e684-4b88-86fe-ef28d6fa690a May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.939 [1912.1912] INFO MediaEngine: [0x556473a0ed50]: Stopping playback, clearing tracks May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.939 [1912.1912] INFO MediaEngine: [0x556473a0ed50]: Initiating playback May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.939 [1912.1912] INFO AudioRenderer: [0x556473a0f150]: Stopping audio renderer May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.939 [1912.1912] INFO SampleApp: Stopping playback May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.948 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: Clearing all streams May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.949 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: [Stream 1]: Disposing of audio stream May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.949 [1912.1912] INFO ContentFetcher: [0x556473b43540]: Canceling download May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.951 [1912.1912] INFO SampleApp: Playback state changed: Stopped May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.951 [1912.1912] INFO StreamingEventReporter: [0x556473a10240]: Reporting streaming ended event May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.951 [1912.1912] INFO HttpDownloader: [0x556473a102d0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.951 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Need to send state update May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.951 [1912.1912] INFO QConnectMessageSender: [0x556473c21960]: Sending StateUpdated message May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.951 [1912.1912] INFO SampleApp: [Stream 1]: Audio stream has been disposed of May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.951 [1912.1912] INFO MediaEngine: [0x556473a0ed50]: Setting current track: 335572303, initial offset: 0ms May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.951 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: Clearing all streams May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.952 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: New stream: 3 May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.952 [1912.1912] INFO HttpDownloader: [0x556473b47620]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=af581075c4ce0afbf77fd71d912b4eec&request_ts=1748110020&track_id=335572303 May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.952 [1912.1912] INFO HttpDownloader: [0x556473c49280]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=335572303 May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.952 [1912.1912] INFO HttpDownloader: [0x556473b40ff0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=2848c2c0b95eb427e830aa2d72bbf11a&request_ts=1748110020&track_id=335572303 May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.952 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: [Stream 3]: Running audio stream May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.952 [1912.1912] INFO QwspMessageSender: [0x556473c21940]: Sending Payload message May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.953 [1912.1912] INFO MediaEngine: [0x556473a0ed50]: Setting next track: 335572304 May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.953 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: New stream: 4 May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.953 [1912.1912] INFO HttpDownloader: [0x556473b43720]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=93e5acca6f4a1d99cc5d6d54e443df44&request_ts=1748110020&track_id=335572304 May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.953 [1912.1912] INFO HttpDownloader: [0x556473b41460]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=335572304 May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.953 [1912.1912] INFO HttpDownloader: [0x556473c95850]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=2b9159e34a1d8c3a422e74db7b61292b&request_ts=1748110020&track_id=335572304 May 24 20:07:00 volumio qobuz-connect[1912]: 20250524 20:07:00.954 [1912.1912] INFO MediaEngine: [0x556473a0ed50]: Waiting for current stream to start before starting audio renderer May 24 20:07:00 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:00 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:07:00 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:07:00 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 20:07:00 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:07:00 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:07:00 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:07:00 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:00 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:00 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:07:00 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:07:00 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 20:07:00 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:07:00 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:07:00 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:07:00 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.059 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: [Stream 3]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2376575&eid=335572303&fmt=7&profile=raw&app_id=174516466&cid=1651531&etsp=1748113621&hmac=Br6VN4WvcN309QVtfNv2EpPFYz4 May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.081 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: [Stream 4]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2376575&eid=335572304&fmt=7&profile=raw&app_id=174516466&cid=1651531&etsp=1748113621&hmac=wgfZyZR-iDHpAr0Yurplz_fQgCQ May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.124 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: [Stream 3]: stream information have been fetched May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.124 [1912.1912] INFO UrlAudioSource: [0x556473d4c1e0]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=2376575&eid=335572303&fmt=7&profile=raw&app_id=174516466&cid=1651531&etsp=1748113621&hmac=Br6VN4WvcN309QVtfNv2EpPFYz4 May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.125 [1912.1912] INFO ContentFetcher: [0x556473c95ee0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=2376575&eid=335572303&fmt=7&profile=raw&app_id=174516466&cid=1651531&etsp=1748113621&hmac=Br6VN4WvcN309QVtfNv2EpPFYz4, offset: 0 May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.125 [1912.1912] INFO AudioRenderer: [0x556473a0f150]: Starting audio renderer, initial playback state: Playing May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.125 [1912.1912] INFO SampleApp: [Stream 3]: New audio stream (starting from 0ms) May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:01 volumio volumio[1053]: info: QobuzConnect: alread currrent service, send playback confirmation May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.126 [1912.1912] INFO SampleApp: Initiating playback, initial state: Playing May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.422 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: [Stream 4]: stream information have been fetched May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.423 [1912.1912] INFO SampleApp: Playback state changed: Playing May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.423 [1912.1912] INFO StreamingEventReporter: [0x556473a10240]: Reporting streaming started event May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.423 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Need to send state update May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.423 [1912.1912] INFO QConnectMessageSender: [0x556473c21960]: Sending StateUpdated message May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.423 [1912.1912] INFO QwspMessageSender: [0x556473c21940]: Sending Payload message May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.423 [1912.1912] INFO QConnectMessageSender: [0x556473c21960]: Sending FileAudioQualityChanged message May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.423 [1912.1912] INFO QwspMessageSender: [0x556473c21940]: Sending Payload message May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.424 [1912.1912] INFO QConnectMessageSender: [0x556473c21960]: Sending DeviceAudioQualityChanged message May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.424 [1912.1912] INFO QwspMessageSender: [0x556473c21940]: Sending Payload message May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.424 [1912.1912] INFO HttpDownloader: [0x556473a102d0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.425 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: [Stream 3]: Metadata became available: May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.425 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: Title: Room On The Porch May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.425 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: Artist: Taj Mahal May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.425 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: Album: Room On The Porch May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.426 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: Album art URL: https://static.qobuz.com/images/covers/ob/ja/tykudegm6jaob_600.jpg May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.426 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: [Stream 4]: Metadata became available: May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.426 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: Title: My Darling My Dear May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.426 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: Artist: Taj Mahal May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:07:01 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.426 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: Album: Room On The Porch May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.426 [1912.1912] INFO AudioStreamManager: [0x556473a0eef0]: Album art URL: https://static.qobuz.com/images/covers/ob/ja/tykudegm6jaob_600.jpg May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.426 [1912.1912] INFO SampleApp: [Stream 3]: Stream metadata became available: May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.426 [1912.1912] INFO SampleApp: Title: Room On The Porch May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.426 [1912.1912] INFO SampleApp: Artist: Taj Mahal May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.426 [1912.1912] INFO SampleApp: Album: Room On The Porch May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.426 [1912.1912] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/ob/ja/tykudegm6jaob_600.jpg May 24 20:07:01 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:07:01 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:07:01 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:07:01 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:07:01 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:07:01 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:07:01 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:07:01 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:07:01 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:07:01 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:07:01 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::servicePushState May 24 20:07:01 volumio volumio[1053]: info: CoreStateMachine::pushState May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioPushState May 24 20:07:01 volumio volumio[1053]: info: MRS: Pushing multiroomSync output update for this device May 24 20:07:01 volumio volumio[1053]: info: MRS: Pushing multiroomSync output May 24 20:07:01 volumio volumio[1053]: info: CoreCommandRouter::volumioGetState May 24 20:07:01 volumio volumio[1053]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! May 24 20:07:01 volumio volumio[1053]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 24 20:07:01 volumio volumio[1053]: TypeError: Cannot read property 'indexOf' of undefined May 24 20:07:01 volumio volumio[1053]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) May 24 20:07:01 volumio volumio[1053]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) May 24 20:07:01 volumio volumio[1053]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) May 24 20:07:01 volumio volumio[1053]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 24 20:07:01 volumio volumio[1053]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) May 24 20:07:01 volumio volumio[1053]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) May 24 20:07:01 volumio volumio[1053]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 24 20:07:01 volumio volumio[1053]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 24 20:07:01 volumio volumio[1053]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) May 24 20:07:01 volumio volumio[1053]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 24 20:07:01 volumio volumio[1053]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) May 24 20:07:01 volumio volumio[1053]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) May 24 20:07:01 volumio volumio[1053]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) May 24 20:07:01 volumio volumio[1053]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 24 20:07:01 volumio volumio[1053]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 24 20:07:01 volumio volumio[1053]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) May 24 20:07:01 volumio volumio[1053]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.556 [1912.1912] INFO UrlAudioSource: [0x556473d4c1e0]: Content info extracted May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.556 [1912.1912] INFO UrlAudioSource: [0x556473d4c1e0]: Size: 53293209 May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.557 [1912.8288] INFO AudioDecoder: [0x556473d075d0]: Stream info: May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.557 [1912.8288] INFO AudioDecoder: [0x556473d075d0]: Total samples: 11783168 May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.557 [1912.8288] INFO AudioDecoder: [0x556473d075d0]: Sample rate: 48000 May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.557 [1912.8288] INFO AudioDecoder: [0x556473d075d0]: Channel count: 2 May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.557 [1912.8288] INFO AudioDecoder: [0x556473d075d0]: Bits per sample: 24 May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.557 [1912.8288] INFO AudioDecoder: [0x556473d075d0]: Duration: 245482 May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.558 [1912.1912] INFO UrlAudioSource: [0x556473d4c1e0]: Audio properties have changed May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.731 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Received SetState message: May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.731 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Playing state: May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.731 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Playback position: May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.731 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Queue version: 42.2 May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.731 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Current track: May 24 20:07:01 volumio qobuz-connect[1912]: 20250524 20:07:01.731 [1912.1912] INFO ProtocolHandler: [0x556473a0faa0]: Next track: TID: 335572304, QID: 1, Context UUID: 53c44484-e684-4b88-86fe-ef28d6fa690a May 24 20:07:01 volumio sudo[8296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-24 20:06 May 24 20:07:01 volumio sudo[8296]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"