Oct 15 15:30:45 volumio qobuz-connect[2419]: 20261015 15:30:45.589 [2419.2471] INFO SampleApp: API endpoint invoked: get-display-info Oct 15 15:30:45 volumio qobuz-connect[2419]: 20261015 15:30:45.624 [2419.2471] INFO SampleApp: API endpoint invoked: get-connect-info Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.637 [2419.2471] INFO SampleApp: API endpoint invoked: connect-to-qconnect Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.637 [2419.2419] INFO EndpointManager: [0x55d847b81c10]: Updating API endpoint Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.637 [2419.2419] INFO EndpointManager: [0x55d847b81c10]: Updating QConnect endpoint Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.637 [2419.2419] INFO ActiveStateManager: [0x55d847b800f0]: Setting new active state: active Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.637 [2419.2419] INFO PlaybackSessionManager: [0x55d847b821a0]: Starting playback session maintenance Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.637 [2419.2419] INFO HttpDownloader: [0x55d847b82490]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.637 [2419.2419] INFO CloudClient: [0x55d847b82dc0]: Connecting to the cloud Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.637 [2419.2419] INFO SampleApp: Renderer is now active Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.813 [2419.2419] INFO CloudClient: [0x55d847b82dc0]: Connection established Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.813 [2419.2419] INFO QwspMessageSender: [0x55d847ce5a10]: Sending Authenticate message Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.813 [2419.2419] INFO QwspMessageSender: [0x55d847ce5a10]: Sending Subscribe message Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.813 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending JoinSession message Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.813 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending VolumeChanged message Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.813 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending VolumeMuted message Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.813 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending MaxAudioQualityChanged message Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.813 [2419.2419] INFO QwspMessageSender: [0x55d847ce5a10]: Sending Payload message Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Received SetActive message: active Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Received SetState message: Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Playing state: Paused Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Playback position: 29598 Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Queue version: 10.1 Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Current track: TID: 46264840, QID: 14, Context UUID: 1e8037f8-609c-489f-86c1-fd9662a73d92 Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Next track: TID: 2543838, QID: 15, Context UUID: 1e8037f8-609c-489f-86c1-fd9662a73d92 Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Stopping playback, clearing tracks Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Initiating playback Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Received SetLoopMode message: Off Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO PlaybackModeManager: [0x55d847b82a30]: Setting new loop mode: Off Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Setting current track: 46264840, initial offset: 29598ms Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: Clearing all streams Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: New stream: 53 Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO HttpDownloader: [0x55d847bd3fe0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=25bf426dd71c8abcef1f4d1f66798b6e&request_ts=1792071046&track_id=46264840 Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO HttpDownloader: [0x55d847c99260]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=46264840 Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 53]: Running audio stream Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Received SetShuffleMode message: disabled Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO PlaybackModeManager: [0x55d847b82a30]: Setting new shuffle mode: disabled Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Setting next track: 2543838 Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: New stream: 54 Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO HttpDownloader: [0x55d847e9d9a0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=0edf98c49a71c5a70599e64fffaa0b18&request_ts=1792071046&track_id=2543838 Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO HttpDownloader: [0x55d848661520]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=2543838 Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.865 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Waiting for current stream to start before starting audio renderer Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.919 [2419.2419] INFO PlaybackSessionManager: [0x55d847b821a0]: Playback session has been refreshed Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.919 [2419.2419] INFO HttpDownloader: [0x55d847c47150]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=656be64fba7fd11ac895fd7f43d2f0d5&request_ts=1792071046&track_id=46264840 Oct 15 15:30:46 volumio qobuz-connect[2419]: 20261015 15:30:46.919 [2419.2419] INFO HttpDownloader: [0x55d847bd9970]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=d94655b2ba3ea727cc565afb119f4c1a&request_ts=1792071046&track_id=2543838 Oct 15 15:30:47 volumio qobuz-connect[2419]: 20261015 15:30:47.005 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 54]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=2543838&fmt=6&profile=raw&app_id=174516466&cid=3860144&etsp=1792074646&hmac=NvWcfEKRoaec8UTmLxgDC2gCCQI Oct 15 15:30:47 volumio qobuz-connect[2419]: 20261015 15:30:47.032 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 53]: Metadata became available: Oct 15 15:30:47 volumio qobuz-connect[2419]: 20261015 15:30:47.032 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: Title: Birds Oct 15 15:30:47 volumio qobuz-connect[2419]: 20261015 15:30:47.032 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: Artist: Dominique Fils-Aimé Oct 15 15:30:47 volumio qobuz-connect[2419]: 20261015 15:30:47.032 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: Album: Nameless Oct 15 15:30:47 volumio qobuz-connect[2419]: 20261015 15:30:47.032 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: Album art URL: https://static.qobuz.com/images/covers/04/09/0623339210904_600.jpg Oct 15 15:30:47 volumio qobuz-connect[2419]: 20261015 15:30:47.170 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 53]: stream information have been fetched Oct 15 15:30:47 volumio qobuz-connect[2419]: 20261015 15:30:47.178 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 54]: stream information have been fetched Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.178 [2419.2419] ERROR HttpDownloader: [0x55d848661520]: Server responded with error code: 502 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.178 [2419.2419] INFO HttpDownloader: [0x55d848661520]: Canceling download Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.178 [2419.2419] ERROR MetadataFetcher: [0x55d847b85270]: Unable to fetch metadata for track: 2543838 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.190 [2419.2419] ERROR HttpDownloader: [0x55d847bd3fe0]: Server responded with error code: 502 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.190 [2419.2419] INFO HttpDownloader: [0x55d847bd3fe0]: Canceling download Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.190 [2419.2419] ERROR PlaybackUrlFetcher: [0x55d848188100]: Unable to fetch playback URL for track: 46264840 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.190 [2419.2419] ERROR AudioStreamManager: [0x55d847b82680]: [Stream 53]: error resolving playback URL for track: 46264840 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.190 [2419.2419] ERROR MediaEngine: [0x55d847b82550]: Current stream has encountered an error Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.190 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending PlaybackError message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.190 [2419.2419] INFO QwspMessageSender: [0x55d847ce5a10]: Sending Payload message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.190 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Need to send state update Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.190 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending StateUpdated message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.190 [2419.2419] INFO QwspMessageSender: [0x55d847ce5a10]: Sending Payload message Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::servicePushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreStateMachine::pushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioPushState Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] using existing timer Oct 15 15:30:48 volumio volumio[1355]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 234 | title: Die On This Hill (At KOKO) | previous title: Die On This Hill (At KOKO) Oct 15 15:30:48 volumio volumio[1355]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792063423279 Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] Song has been paused, so also pausing timer. Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Received SetState message: Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Playing state: Playing Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Playback position: 0 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Queue version: 10.1 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Current track: TID: 2543838, QID: 15, Context UUID: 1e8037f8-609c-489f-86c1-fd9662a73d92 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Next track: TID: 10472798, QID: 16, Context UUID: 1e8037f8-609c-489f-86c1-fd9662a73d92 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Reseting Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Stopping playback, clearing tracks Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Initiating playback Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Need to send state update Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending StateUpdated message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO QwspMessageSender: [0x55d847ce5a10]: Sending Payload message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Setting current track: 2543838, initial offset: 0ms Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: Clearing all streams Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 53]: Disposing of audio stream Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.238 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: New stream: 55 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.239 [2419.2419] INFO HttpDownloader: [0x55d847b85270]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=e88c1e967d6ff0378680c1fe227dae3d&request_ts=1792071048&track_id=2543838 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.239 [2419.2419] INFO HttpDownloader: [0x55d8482dba00]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=2543838 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.239 [2419.2419] INFO HttpDownloader: [0x55d847c9b9e0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=2bf1e8c72bc3ca7410cf3c45dc6c1ad7&request_ts=1792071048&track_id=2543838 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.239 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 55]: Running audio stream Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.239 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Setting next track: 10472798 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.239 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: New stream: 56 Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::servicePushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreStateMachine::pushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioPushState Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.239 [2419.2419] INFO HttpDownloader: [0x55d847bd3fe0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=2c60b1c37f30e3d7d75a6ace5f8d0cae&request_ts=1792071048&track_id=10472798 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.239 [2419.2419] INFO HttpDownloader: [0x55d847bd9970]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=10472798 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.239 [2419.2419] INFO HttpDownloader: [0x55d847d8b290]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=8397f2beeafc2d30d4c5fc9a54e8dd1f&request_ts=1792071048&track_id=10472798 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.239 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Waiting for current stream to start before starting audio renderer Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] using existing timer Oct 15 15:30:48 volumio volumio[1355]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 234 | title: Die On This Hill (At KOKO) | previous title: Die On This Hill (At KOKO) Oct 15 15:30:48 volumio volumio[1355]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792063423279 Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] Song has been paused, so also pausing timer. Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.299 [2419.2419] ERROR HttpDownloader: [0x55d847bd3fe0]: Server responded with error code: 502 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.299 [2419.2419] INFO HttpDownloader: [0x55d847bd3fe0]: Canceling download Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.299 [2419.2419] ERROR PlaybackUrlFetcher: [0x55d847e02eb0]: Unable to fetch playback URL for track: 10472798 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.299 [2419.2419] ERROR AudioStreamManager: [0x55d847b82680]: [Stream 56]: error resolving playback URL for track: 10472798 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.299 [2419.2419] ERROR MediaEngine: [0x55d847b82550]: Next stream has encountered an error Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.301 [2419.2419] ERROR HttpDownloader: [0x55d847b85270]: Server responded with error code: 502 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.301 [2419.2419] INFO HttpDownloader: [0x55d847b85270]: Canceling download Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.301 [2419.2419] ERROR PlaybackUrlFetcher: [0x55d8481885d0]: Unable to fetch playback URL for track: 2543838 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.301 [2419.2419] ERROR AudioStreamManager: [0x55d847b82680]: [Stream 55]: error resolving playback URL for track: 2543838 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.301 [2419.2419] ERROR MediaEngine: [0x55d847b82550]: Current stream has encountered an error Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.301 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending PlaybackError message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.301 [2419.2419] INFO QwspMessageSender: [0x55d847ce5a10]: Sending Payload message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.301 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Need to send state update Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.301 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending StateUpdated message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.301 [2419.2419] INFO QwspMessageSender: [0x55d847ce5a10]: Sending Payload message Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::servicePushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreStateMachine::pushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioPushState Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] using existing timer Oct 15 15:30:48 volumio volumio[1355]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 234 | title: Die On This Hill (At KOKO) | previous title: Die On This Hill (At KOKO) Oct 15 15:30:48 volumio volumio[1355]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792063423279 Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] Song has been paused, so also pausing timer. Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.328 [2419.2419] ERROR HttpDownloader: [0x55d847d8b290]: Server responded with error code: 502 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.328 [2419.2419] INFO HttpDownloader: [0x55d847d8b290]: Canceling download Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.328 [2419.2419] ERROR AudioStreamInfoFetcher: [0x55d847f50b80]: Unable to fetch audio stream information for track: 10472798 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.328 [2419.2419] ERROR AudioStreamManager: [0x55d847b82680]: [Stream 56]: error fetching stream information for track: 10472798 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Received SetState message: Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Playing state: Playing Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Playback position: 0 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Queue version: 10.1 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Current track: TID: 10472798, QID: 16, Context UUID: 1e8037f8-609c-489f-86c1-fd9662a73d92 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Next track: TID: 18454159, QID: 17, Context UUID: 1e8037f8-609c-489f-86c1-fd9662a73d92 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Reseting Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Stopping playback, clearing tracks Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Initiating playback Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Need to send state update Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending StateUpdated message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO QwspMessageSender: [0x55d847ce5a10]: Sending Payload message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Setting current track: 10472798, initial offset: 0ms Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: Clearing all streams Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 55]: Disposing of audio stream Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.348 [2419.2419] INFO HttpDownloader: [0x55d847c9b9e0]: Canceling download Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO HttpDownloader: [0x55d8482dba00]: Canceling download Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 56]: Disposing of audio stream Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO HttpDownloader: [0x55d847bd9970]: Canceling download Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: New stream: 57 Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::servicePushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreStateMachine::pushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioPushState Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO HttpDownloader: [0x55d847d10bc0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=2c60b1c37f30e3d7d75a6ace5f8d0cae&request_ts=1792071048&track_id=10472798 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO HttpDownloader: [0x55d848232f80]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=10472798 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO HttpDownloader: [0x55d847cd0d60]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=8397f2beeafc2d30d4c5fc9a54e8dd1f&request_ts=1792071048&track_id=10472798 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 57]: Running audio stream Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Setting next track: 18454159 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: New stream: 58 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO HttpDownloader: [0x55d847b85270]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=622724de49d41f9b4c82da026483aff0&request_ts=1792071048&track_id=18454159 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO HttpDownloader: [0x55d847f531e0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=18454159 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO HttpDownloader: [0x55d848189c00]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=46344df2d83276b9194cca67213e41da&request_ts=1792071048&track_id=18454159 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.349 [2419.2419] INFO MediaEngine: [0x55d847b82550]: Waiting for current stream to start before starting audio renderer Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] using existing timer Oct 15 15:30:48 volumio volumio[1355]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 234 | title: Die On This Hill (At KOKO) | previous title: Die On This Hill (At KOKO) Oct 15 15:30:48 volumio volumio[1355]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792063423279 Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] Song has been paused, so also pausing timer. Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.440 [2419.2419] ERROR HttpDownloader: [0x55d848232f80]: Server responded with error code: 502 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.440 [2419.2419] INFO HttpDownloader: [0x55d848232f80]: Canceling download Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.440 [2419.2419] ERROR MetadataFetcher: [0x55d847c47150]: Unable to fetch metadata for track: 10472798 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.458 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 57]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=10472798&fmt=27&profile=raw&app_id=174516466&cid=3860144&etsp=1792074648&hmac=U0vLwrq0fji5UusX33du6zFPnm4 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.472 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 58]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=18454159&fmt=7&profile=raw&app_id=174516466&cid=3860144&etsp=1792074648&hmac=cja_STHdCpqDn_Dv63Ka9hJDOZE Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.502 [2419.2419] ERROR HttpDownloader: [0x55d848189c00]: Server responded with error code: 502 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.502 [2419.2419] INFO HttpDownloader: [0x55d848189c00]: Canceling download Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.502 [2419.2419] ERROR AudioStreamInfoFetcher: [0x55d848188210]: Unable to fetch audio stream information for track: 18454159 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.502 [2419.2419] ERROR AudioStreamManager: [0x55d847b82680]: [Stream 58]: error fetching stream information for track: 18454159 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.502 [2419.2419] ERROR MediaEngine: [0x55d847b82550]: Next stream has encountered an error Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.557 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 57]: stream information have been fetched Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.557 [2419.2419] INFO UrlAudioSource: [0x55d848296cb0]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=10472798&fmt=27&profile=raw&app_id=174516466&cid=3860144&etsp=1792074648&hmac=U0vLwrq0fji5UusX33du6zFPnm4 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.557 [2419.2419] INFO ContentFetcher: [0x55d847f50ab0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=10433069&eid=10472798&fmt=27&profile=raw&app_id=174516466&cid=3860144&etsp=1792074648&hmac=U0vLwrq0fji5UusX33du6zFPnm4, offset: 0 Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.557 [2419.2419] INFO AudioRenderer: [0x55d847b827d0]: Starting audio renderer, initial playback state: Playing Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.557 [2419.2419] INFO SampleApp: [Stream 57]: New audio stream (starting from 0ms) Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: QobuzConnect: alread currrent service, send playback confirmation Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.558 [2419.2419] INFO SampleApp: Initiating playback, initial state: Playing Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.561 [2419.2419] INFO SampleApp: Playback state changed: Playing Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.561 [2419.2419] INFO StreamingEventReporter: [0x55d847b83690]: Reporting streaming started event Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.561 [2419.2419] INFO HttpDownloader: [0x55d847b83720]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.561 [2419.2419] INFO ProtocolHandler: [0x55d847b82fc0]: Need to send state update Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.561 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending StateUpdated message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.561 [2419.2419] INFO QwspMessageSender: [0x55d847ce5a10]: Sending Payload message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.561 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending FileAudioQualityChanged message Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::servicePushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreStateMachine::pushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.561 [2419.2419] INFO QwspMessageSender: [0x55d847ce5a10]: Sending Payload message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.561 [2419.2419] INFO QConnectMessageSender: [0x55d847cd0920]: Sending DeviceAudioQualityChanged message Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.561 [2419.2419] INFO QwspMessageSender: [0x55d847ce5a10]: Sending Payload message Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioPushState Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::servicePushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreStateMachine::pushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioPushState Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::servicePushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreStateMachine::pushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioPushState Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::servicePushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreStateMachine::pushState Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioPushState Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output update for this device Oct 15 15:30:48 volumio volumio[1355]: info: MRS: Pushing multiroomSync output Oct 15 15:30:48 volumio volumio[1355]: info: CoreCommandRouter::volumioGetState Oct 15 15:30:48 volumio volumio[1355]: info: Display-configuration --- Volumio status=pause timeout=300 noifplay=true screensavertype=dpms Oct 15 15:30:48 volumio volumio[1355]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 15 15:30:48 volumio volumio[1355]: info: Display-configuration --- → Wakeup triggered Oct 15 15:30:48 volumio volumio[1355]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 15 15:30:48 volumio volumio[1355]: info: Display-configuration --- → Wakeup triggered Oct 15 15:30:48 volumio volumio[1355]: info: Display-configuration --- Volumio status=play timeout=300 noifplay=true screensavertype=dpms Oct 15 15:30:48 volumio volumio[1355]: info: Display-configuration --- → Wakeup triggered Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] using existing timer Oct 15 15:30:48 volumio volumio[1355]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: pause | service: qobuzconnect | duration: 263 | title: | previous title: Die On This Hill (At KOKO) Oct 15 15:30:48 volumio volumio[1355]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792063423279 Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] Song has been paused, so also pausing timer. Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] using existing timer Oct 15 15:30:48 volumio volumio[1355]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: qobuzconnect | duration: 263 | title: | previous title: Die On This Hill (At KOKO) Oct 15 15:30:48 volumio volumio[1355]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792063423279 Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] using existing timer Oct 15 15:30:48 volumio volumio[1355]: info: --------------------------------------------------------------------// [LastFM] new state has been pushed; status: play | service: qobuzconnect | duration: 263 | title: undefined | previous title: Oct 15 15:30:48 volumio volumio[1355]: info: =================> [timer] is active: false | can continue: false | timer started at: 1792063423279 Oct 15 15:30:48 volumio volumio[1355]: info: [LastFM] Playback detected, evaluating parameters for scrobbling... Oct 15 15:30:48 volumio volumio[1355]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 15:30:48 volumio volumio[1355]: TypeError: Cannot read properties of undefined (reading 'indexOf') Oct 15 15:30:48 volumio volumio[1355]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) Oct 15 15:30:48 volumio volumio[1355]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) Oct 15 15:30:48 volumio volumio[1355]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) Oct 15 15:30:48 volumio volumio[1355]: at Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Oct 15 15:30:48 volumio volumio[1355]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) Oct 15 15:30:48 volumio volumio[1355]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) Oct 15 15:30:48 volumio volumio[1355]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Oct 15 15:30:48 volumio volumio[1355]: at Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Oct 15 15:30:48 volumio volumio[1355]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) Oct 15 15:30:48 volumio volumio[1355]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Oct 15 15:30:48 volumio volumio[1355]: at Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Oct 15 15:30:48 volumio volumio[1355]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) Oct 15 15:30:48 volumio volumio[1355]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) Oct 15 15:30:48 volumio volumio[1355]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Oct 15 15:30:48 volumio volumio[1355]: at Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Oct 15 15:30:48 volumio volumio[1355]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) Oct 15 15:30:48 volumio volumio[1355]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.600 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: [Stream 58]: Metadata became available: Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.602 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: Title: In My Secret Life Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.602 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: Artist: Leonard Cohen Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.603 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: Album: Ten New Songs Oct 15 15:30:48 volumio qobuz-connect[2419]: 20261015 15:30:48.603 [2419.2419] INFO AudioStreamManager: [0x55d847b82680]: Album art URL: https://static.qobuz.com/images/covers/47/80/0886443398047_600.jpg Oct 15 15:30:48 volumio sudo[56761]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-15 15:29' Oct 15 15:30:48 volumio sudo[56761]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"