-- Logs begin at Thu 2019-02-14 10:11:58 GMT, end at Thu 2025-05-15 13:08:08 BST. -- May 15 13:07:57 officeaudio qobuz-connect[1702]: 20250515 13:07:57.852 [1702.2261] INFO SampleApp: API endpoint invoked: get-display-info May 15 13:07:58 officeaudio qobuz-connect[1702]: 20250515 13:07:58.026 [1702.2261] INFO SampleApp: API endpoint invoked: get-connect-info May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.370 [1702.2261] INFO SampleApp: API endpoint invoked: connect-to-qconnect May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.370 [1702.1702] INFO EndpointManager: [0x204a188]: Updating API endpoint May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.370 [1702.1702] INFO EndpointManager: [0x204a188]: Updating QConnect endpoint May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.370 [1702.1702] INFO ActiveStateManager: [0x20491a0]: Setting new active state: active May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.370 [1702.1702] INFO PlaybackSessionManager: [0x204a578]: Starting playback session maintenance May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.370 [1702.1702] INFO HttpDownloader: [0x204a768]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.370 [1702.1702] INFO CloudClient: [0x204ade8]: Connecting to the cloud May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.370 [1702.1702] INFO SampleApp: Renderer is now active May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.508 [1702.1702] INFO CloudClient: [0x204ade8]: Connection established May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.508 [1702.1702] INFO QwspMessageSender: [0x2154ee0]: Sending Authenticate message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.508 [1702.1702] INFO QwspMessageSender: [0x2154ee0]: Sending Subscribe message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.508 [1702.1702] INFO QConnectMessageSender: [0x208a928]: Sending JoinSession message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.508 [1702.1702] INFO QConnectMessageSender: [0x208a928]: Sending VolumeChanged message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.508 [1702.1702] INFO QConnectMessageSender: [0x208a928]: Sending VolumeMuted message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.508 [1702.1702] INFO QConnectMessageSender: [0x208a928]: Sending MaxAudioQualityChanged message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.508 [1702.1702] INFO QwspMessageSender: [0x2154ee0]: Sending Payload message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.539 [1702.1702] INFO ProtocolHandler: [0x204af50]: Received SetActive message: active May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.539 [1702.1702] INFO ProtocolHandler: [0x204af50]: Received SetState message: May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.539 [1702.1702] INFO ProtocolHandler: [0x204af50]: Playing state: Paused May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.539 [1702.1702] INFO ProtocolHandler: [0x204af50]: Playback position: 388132 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.539 [1702.1702] INFO ProtocolHandler: [0x204af50]: Queue version: 2.1 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO ProtocolHandler: [0x204af50]: Current track: TID: 320611363, QID: 9, Context UUID: 89e4d7ce-fae2-415d-ac0e-d7e2d292d578 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO ProtocolHandler: [0x204af50]: Next track: TID: 4294967295, QID: -1, Context UUID: May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO MediaEngine: [0x204a810]: Stopping playback, clearing tracks May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO MediaEngine: [0x204a810]: Initiating playback May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO ProtocolHandler: [0x204af50]: Received SetLoopMode message: Off May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO PlaybackControlsManager: [0x204abe8]: Setting new loop mode: Off May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO MediaEngine: [0x204a810]: Setting current track: 320611363, initial offset: 388132ms May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Clearing all streams May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: New stream: 1 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO HttpDownloader: [0x2125ec8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=d94ed0763a1f20992f57d41709f35d20&request_ts=1747310879&track_id=320611363 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO HttpDownloader: [0x2126e58]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=320611363 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: [Stream 1]: Running audio stream May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO ProtocolHandler: [0x204af50]: Received SetShuffleMode message: disabled May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO PlaybackControlsManager: [0x204abe8]: Setting new shuffle mode: disabled May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO MediaEngine: [0x204a810]: Setting next track: NONE May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.540 [1702.1702] INFO MediaEngine: [0x204a810]: Waiting for current stream to start before starting audio renderer May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.545 [1702.1702] INFO PlaybackSessionManager: [0x204a578]: Playback session has been refreshed May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.546 [1702.1702] INFO HttpDownloader: [0x20504c0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=2de9cef8802c53e864c96131035b5551&request_ts=1747310879&track_id=320611363 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.641 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2358809&eid=320611363&fmt=7&profile=raw&app_id=174516466&cid=1669468&etsp=1747314479&hmac=G5fJr79owpeuWSX0cdsuR0eb-_U May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.669 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: [Stream 1]: Metadata became available: May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.670 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Title: Infinite Baths May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.670 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Artist: Sleep Token May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.670 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Album: Even In Arcadia May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.670 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Album art URL: https://static.qobuz.com/images/covers/ma/g5/zo922etceg5ma_600.jpg May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.684 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: [Stream 1]: stream information have been fetched May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.684 [1702.1702] INFO UrlAudioSource: [0x21eb5b0]: Starting URL audio source, initial position: 388132ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=2358809&eid=320611363&fmt=7&profile=raw&app_id=174516466&cid=1669468&etsp=1747314479&hmac=G5fJr79owpeuWSX0cdsuR0eb-_U May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.685 [1702.1702] INFO ContentFetcher: [0x2050fd0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=2358809&eid=320611363&fmt=7&profile=raw&app_id=174516466&cid=1669468&etsp=1747314479&hmac=G5fJr79owpeuWSX0cdsuR0eb-_U, offset: 0 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.685 [1702.1702] INFO AudioRenderer: [0x204aa30]: Starting audio renderer, initial playback state: Paused May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.685 [1702.1702] INFO SampleApp: [Stream 1]: New audio stream (starting from 388131ms) May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.685 [1702.1702] INFO SampleApp: [Stream 1]: Stream metadata became available: May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.685 [1702.1702] INFO SampleApp: Title: Infinite Baths May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.685 [1702.1702] INFO SampleApp: Artist: Sleep Token May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.685 [1702.1702] INFO SampleApp: Album: Even In Arcadia May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.685 [1702.1702] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/ma/g5/zo922etceg5ma_600.jpg May 15 13:07:59 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:07:59 officeaudio volumio[1116]: info: CorePlayQueue::getTrack 0 May 15 13:07:59 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:07:59 officeaudio volumio[1116]: info: CorePlayQueue::getTrack 0 May 15 13:07:59 officeaudio volumio[1116]: info: QobuzConnect: setActiveState() May 15 13:07:59 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:07:59 officeaudio volumio[1116]: info: CorePlayQueue::getTrack 0 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.690 [1702.1702] INFO VolumeManager: [0x204ac78]: Setting new playback volume: 100 May 15 13:07:59 officeaudio volumio[1116]: info: QobuzConnect: Set Qobuz connect default volume to 100 May 15 13:07:59 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:07:59 officeaudio volumio[1116]: info: CorePlayQueue::getTrack 0 May 15 13:07:59 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:07:59 officeaudio volumio[1116]: info: CorePlayQueue::getTrack 0 May 15 13:07:59 officeaudio volumio[1116]: info: QobuzConnect: Stopping currently active service May 15 13:07:59 officeaudio volumio[1116]: info: CoreCommandRouter::volumioStop May 15 13:07:59 officeaudio volumio[1116]: info: CoreStateMachine::stop May 15 13:07:59 officeaudio volumio[1116]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 13:07:59 officeaudio volumio[1116]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 13:07:59 officeaudio volumio[1116]: info: CoreCommandRouter::servicePushState May 15 13:07:59 officeaudio volumio[1116]: info: CoreStateMachine::pushState May 15 13:07:59 officeaudio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 13:07:59 officeaudio volumio[1116]: info: CoreCommandRouter::volumioPushState May 15 13:07:59 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:07:59 officeaudio volumio[1116]: info: CorePlayQueue::getTrack 0 May 15 13:07:59 officeaudio volumio[1116]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect May 15 13:07:59 officeaudio volumio[1116]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect May 15 13:07:59 officeaudio volumio[1116]: info: QobuzConnect: setActiveState() completed, send playback confirmation May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.705 [1702.1702] INFO SampleApp: Initiating playback, initial state: Paused May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.765 [1702.1702] INFO SampleApp: Playback state changed: Paused May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.766 [1702.1702] INFO ProtocolHandler: [0x204af50]: Need to send state update May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.766 [1702.1702] INFO QConnectMessageSender: [0x208a928]: Sending StateUpdated message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.766 [1702.1702] INFO QwspMessageSender: [0x2154ee0]: Sending Payload message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.766 [1702.1702] INFO QConnectMessageSender: [0x208a928]: Sending FileAudioQualityChanged message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.766 [1702.1702] INFO QwspMessageSender: [0x2154ee0]: Sending Payload message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.766 [1702.1702] INFO QConnectMessageSender: [0x208a928]: Sending DeviceAudioQualityChanged message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.766 [1702.1702] INFO QwspMessageSender: [0x2154ee0]: Sending Payload message May 15 13:07:59 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.794 [1702.1702] INFO UrlAudioSource: [0x21eb5b0]: Content info extracted May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.794 [1702.1702] INFO UrlAudioSource: [0x21eb5b0]: Size: 96711725 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.795 [1702.2268] INFO AudioDecoder: [0x22bc590]: Stream info: May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.795 [1702.2268] INFO AudioDecoder: [0x22bc590]: Total samples: 22193717 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.795 [1702.2268] INFO AudioDecoder: [0x22bc590]: Sample rate: 44100 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.795 [1702.2268] INFO AudioDecoder: [0x22bc590]: Channel count: 2 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.795 [1702.2268] INFO AudioDecoder: [0x22bc590]: Bits per sample: 24 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.795 [1702.2268] INFO AudioDecoder: [0x22bc590]: Duration: 503258 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.795 [1702.1702] INFO UrlAudioSource: [0x21eb5b0]: Audio properties have changed May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.795 [1702.1702] INFO UrlAudioSource: [0x21eb5b0]: Seeking input stream to byte offset: 73947203 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.795 [1702.1702] INFO ContentFetcher: [0x2050fd0]: Adjusting download offset to: 73947203 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.841 [1702.1702] INFO SampleApp: Playback volume changed: 100 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.841 [1702.1702] INFO ProtocolHandler: [0x204af50]: Volume changed: 100 May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.841 [1702.1702] INFO QConnectMessageSender: [0x208a928]: Sending VolumeChanged message May 15 13:07:59 officeaudio qobuz-connect[1702]: 20250515 13:07:59.841 [1702.1702] INFO QwspMessageSender: [0x2154ee0]: Sending Payload message May 15 13:07:59 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.322 [1702.1702] INFO ProtocolHandler: [0x204af50]: Received SetState message: May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.322 [1702.1702] INFO ProtocolHandler: [0x204af50]: Playing state: Playing May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.322 [1702.1702] INFO ProtocolHandler: [0x204af50]: Playback position: 0 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.322 [1702.1702] INFO ProtocolHandler: [0x204af50]: Queue version: 3.1 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.322 [1702.1702] INFO ProtocolHandler: [0x204af50]: Current track: TID: 330887719, QID: 0, Context UUID: 2542dfa5-13dc-49bf-9464-1e573d38dedc May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.322 [1702.1702] INFO ProtocolHandler: [0x204af50]: Next track: TID: 19906024, QID: 1, Context UUID: 2542dfa5-13dc-49bf-9464-1e573d38dedc May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.322 [1702.1702] INFO MediaEngine: [0x204a810]: Stopping playback, clearing tracks May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.322 [1702.1702] INFO MediaEngine: [0x204a810]: Initiating playback May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.322 [1702.1702] INFO AudioRenderer: [0x204aa30]: Stopping audio renderer May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.322 [1702.1702] INFO RendererActionAvailabilityManager: [0x204aea0]: Renderer action 'Next' is available May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.322 [1702.1702] INFO SampleApp: Stopping playback May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.335 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Clearing all streams May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.335 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: [Stream 1]: Disposing of audio stream May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.335 [1702.1702] INFO ContentFetcher: [0x2050fd0]: Canceling download May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.338 [1702.1702] INFO SampleApp: Playback state changed: Stopped May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.338 [1702.1702] INFO ProtocolHandler: [0x204af50]: Need to send state update May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.338 [1702.1702] INFO QConnectMessageSender: [0x208a928]: Sending StateUpdated message May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.338 [1702.1702] INFO SampleApp: [Stream 1]: Audio stream has been disposed of May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.338 [1702.1702] INFO MediaEngine: [0x204a810]: Setting current track: 330887719, initial offset: 0ms May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.338 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Clearing all streams May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.338 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: New stream: 2 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.338 [1702.1702] INFO HttpDownloader: [0x2125ce8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=84b2389f2682da778266209f2f517a89&request_ts=1747310888&track_id=330887719 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.339 [1702.1702] INFO HttpDownloader: [0x2050678]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=330887719 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.339 [1702.1702] INFO HttpDownloader: [0x204f1e8]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=5ce612dc3495ed9b58ef07093dba9dfc&request_ts=1747310888&track_id=330887719 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.339 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: [Stream 2]: Running audio stream May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.339 [1702.1702] INFO QwspMessageSender: [0x2154ee0]: Sending Payload message May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.340 [1702.1702] INFO MediaEngine: [0x204a810]: Setting next track: 19906024 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.340 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: New stream: 3 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.340 [1702.1702] INFO HttpDownloader: [0x2212968]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=0203413a706ed846c2587b2371af9610&request_ts=1747310888&track_id=19906024 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.340 [1702.1702] INFO HttpDownloader: [0x2282ae8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=19906024 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.340 [1702.1702] INFO HttpDownloader: [0x2086a48]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=13619240b3158607dbc95165120af42a&request_ts=1747310888&track_id=19906024 May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.341 [1702.1702] INFO MediaEngine: [0x204a810]: Waiting for current stream to start before starting audio renderer May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.428 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: [Stream 3]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2358809&eid=19906024&fmt=7&profile=raw&app_id=174516466&cid=1669468&etsp=1747314488&hmac=3X_mrl-dIPjg7J5B1dDPzHDDTLk May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.467 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2358809&eid=330887719&fmt=7&profile=raw&app_id=174516466&cid=1669468&etsp=1747314488&hmac=c1T4qoy9CCs1hhrTtnPT3qzDLlw May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.477 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: [Stream 3]: stream information have been fetched May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.479 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: [Stream 2]: stream information have been fetched May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.479 [1702.1702] INFO UrlAudioSource: [0x21e6870]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=2358809&eid=330887719&fmt=7&profile=raw&app_id=174516466&cid=1669468&etsp=1747314488&hmac=c1T4qoy9CCs1hhrTtnPT3qzDLlw May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.479 [1702.1702] INFO ContentFetcher: [0x221a738]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=2358809&eid=330887719&fmt=7&profile=raw&app_id=174516466&cid=1669468&etsp=1747314488&hmac=c1T4qoy9CCs1hhrTtnPT3qzDLlw, offset: 0 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.479 [1702.1702] INFO AudioRenderer: [0x204aa30]: Starting audio renderer, initial playback state: Playing May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.479 [1702.1702] INFO SampleApp: [Stream 2]: New audio stream (starting from 0ms) May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio volumio[1116]: info: QobuzConnect: setActiveState() May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio volumio[1116]: info: QobuzConnect: Set Qobuz connect default volume to 100 May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.481 [1702.1702] INFO VolumeManager: [0x204ac78]: Setting new playback volume: 100 May 15 13:08:08 officeaudio volumio[1116]: info: QobuzConnect: Stopping currently active service May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioStop May 15 13:08:08 officeaudio volumio[1116]: info: CoreStateMachine::stop May 15 13:08:08 officeaudio volumio[1116]: info: CoreStateMachine::serviceStop May 15 13:08:08 officeaudio volumio[1116]: info: Received STOP, but no service to execute it May 15 13:08:08 officeaudio volumio[1116]: info: CoreStateMachine::setConsumeUpdateService undefined May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::servicePushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreStateMachine::pushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioPushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio volumio[1116]: info: CorePlayQueue::getTrack 0 May 15 13:08:08 officeaudio volumio[1116]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received qobuzconnect May 15 13:08:08 officeaudio volumio[1116]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect May 15 13:08:08 officeaudio volumio[1116]: info: QobuzConnect: setActiveState() completed, send playback confirmation May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.489 [1702.1702] INFO SampleApp: Initiating playback, initial state: Playing May 15 13:08:08 officeaudio volumio[1116]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.DxASekcaG4NsRgMkpegFO0SKvXm1.e6c411213a9543bd8f367a6506fb851e.state.status' May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.543 [1702.1702] INFO SampleApp: Playback state changed: Playing May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.543 [1702.1702] INFO StreamingEventReporter: [0x204b368]: Reporting streaming started event May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.543 [1702.1702] INFO HttpDownloader: [0x204b3c0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.543 [1702.1702] INFO ProtocolHandler: [0x204af50]: Need to send state update May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.543 [1702.1702] INFO QConnectMessageSender: [0x208a928]: Sending StateUpdated message May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.543 [1702.1702] INFO QwspMessageSender: [0x2154ee0]: Sending Payload message May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.544 [1702.1702] INFO QConnectMessageSender: [0x208a928]: Sending FileAudioQualityChanged message May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.544 [1702.1702] INFO QwspMessageSender: [0x2154ee0]: Sending Payload message May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.544 [1702.1702] INFO QConnectMessageSender: [0x208a928]: Sending DeviceAudioQualityChanged message May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.544 [1702.1702] INFO QwspMessageSender: [0x2154ee0]: Sending Payload message May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::servicePushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreStateMachine::pushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioPushState May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: [Stream 3]: Metadata became available: May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Title: Back In Black May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Artist: AC/DC May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Album: Back In Black May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Album art URL: https://static.qobuz.com/images/covers/41/98/0886444889841_600.jpg May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: [Stream 2]: Metadata became available: May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Title: Peacefield May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Artist: Ghost May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Album: Skeletá May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO AudioStreamManager: [0x204a8f8]: Album art URL: https://static.qobuz.com/images/covers/ua/ef/c0q7h65r6efua_600.jpg May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO SampleApp: [Stream 2]: Stream metadata became available: May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO SampleApp: Title: Peacefield May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO SampleApp: Artist: Ghost May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO SampleApp: Album: Skeletá May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.545 [1702.1702] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/ua/ef/c0q7h65r6efua_600.jpg May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.549 [1702.1702] INFO VolumeManager: [0x204ac78]: Setting new playback volume: 100 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.550 [1702.1702] INFO VolumeManager: [0x204ac78]: Setting new mute state: 0 May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::servicePushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreStateMachine::pushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioPushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::servicePushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreStateMachine::pushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioPushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::servicePushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreStateMachine::pushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioPushState May 15 13:08:08 officeaudio volumio[1116]: info: CoreCommandRouter::volumioGetState May 15 13:08:08 officeaudio volumio[1116]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! May 15 13:08:08 officeaudio volumio[1116]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 13:08:08 officeaudio volumio[1116]: TypeError: Cannot read property 'indexOf' of undefined May 15 13:08:08 officeaudio volumio[1116]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) May 15 13:08:08 officeaudio volumio[1116]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) May 15 13:08:08 officeaudio volumio[1116]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) May 15 13:08:08 officeaudio volumio[1116]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 15 13:08:08 officeaudio volumio[1116]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) May 15 13:08:08 officeaudio volumio[1116]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) May 15 13:08:08 officeaudio volumio[1116]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 15 13:08:08 officeaudio volumio[1116]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 15 13:08:08 officeaudio volumio[1116]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) May 15 13:08:08 officeaudio volumio[1116]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 15 13:08:08 officeaudio volumio[1116]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) May 15 13:08:08 officeaudio volumio[1116]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) May 15 13:08:08 officeaudio volumio[1116]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) May 15 13:08:08 officeaudio volumio[1116]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 15 13:08:08 officeaudio volumio[1116]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 15 13:08:08 officeaudio volumio[1116]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) May 15 13:08:08 officeaudio volumio[1116]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.621 [1702.1702] INFO UrlAudioSource: [0x21e6870]: Content info extracted May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.621 [1702.1702] INFO UrlAudioSource: [0x21e6870]: Size: 77533214 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.625 [1702.2291] INFO AudioDecoder: [0x22ac898]: Stream info: May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.625 [1702.2291] INFO AudioDecoder: [0x22ac898]: Total samples: 16358238 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.625 [1702.2291] INFO AudioDecoder: [0x22ac898]: Sample rate: 48000 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.625 [1702.2291] INFO AudioDecoder: [0x22ac898]: Channel count: 2 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.625 [1702.2291] INFO AudioDecoder: [0x22ac898]: Bits per sample: 24 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.625 [1702.2291] INFO AudioDecoder: [0x22ac898]: Duration: 340796 May 15 13:08:08 officeaudio qobuz-connect[1702]: 20250515 13:08:08.625 [1702.1702] INFO UrlAudioSource: [0x21e6870]: Audio properties have changed May 15 13:08:08 officeaudio sudo[2294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-15 13:07 May 15 13:08:08 officeaudio sudo[2294]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"