-- Logs begin at Wed 2025-05-21 21:33:36 CEST, end at Wed 2025-05-21 21:42:18 CEST. -- May 21 21:42:15 volumio qobuz-connect[1803]: 20250521 21:42:15.035 [1803.2954] INFO SampleApp: API endpoint invoked: get-display-info May 21 21:42:15 volumio qobuz-connect[1803]: 20250521 21:42:15.070 [1803.2954] INFO SampleApp: API endpoint invoked: get-connect-info May 21 21:42:16 volumio qobuz-connect[1803]: 20250521 21:42:16.851 [1803.2954] INFO SampleApp: API endpoint invoked: connect-to-qconnect May 21 21:42:16 volumio qobuz-connect[1803]: 20250521 21:42:16.852 [1803.1803] INFO EndpointManager: [0x5563533ca140]: Updating API endpoint May 21 21:42:16 volumio qobuz-connect[1803]: 20250521 21:42:16.852 [1803.1803] INFO EndpointManager: [0x5563533ca140]: Updating QConnect endpoint May 21 21:42:16 volumio qobuz-connect[1803]: 20250521 21:42:16.852 [1803.1803] INFO ActiveStateManager: [0x5563533c8520]: Setting new active state: active May 21 21:42:16 volumio qobuz-connect[1803]: 20250521 21:42:16.852 [1803.1803] INFO PlaybackSessionManager: [0x5563533ca880]: Starting playback session maintenance May 21 21:42:16 volumio qobuz-connect[1803]: 20250521 21:42:16.852 [1803.1803] INFO HttpDownloader: [0x5563533cac00]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start May 21 21:42:16 volumio qobuz-connect[1803]: 20250521 21:42:16.852 [1803.1803] INFO CloudClient: [0x5563533cb7f0]: Connecting to the cloud May 21 21:42:16 volumio qobuz-connect[1803]: 20250521 21:42:16.852 [1803.1803] INFO SampleApp: Renderer is now active May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.099 [1803.1803] INFO CloudClient: [0x5563533cb7f0]: Connection established May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.100 [1803.1803] INFO QwspMessageSender: [0x5563535dd940]: Sending Authenticate message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.100 [1803.1803] INFO QwspMessageSender: [0x5563535dd940]: Sending Subscribe message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.100 [1803.1803] INFO QConnectMessageSender: [0x5563535dd960]: Sending JoinSession message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.100 [1803.1803] INFO QConnectMessageSender: [0x5563535dd960]: Sending VolumeChanged message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.100 [1803.1803] INFO QConnectMessageSender: [0x5563535dd960]: Sending VolumeMuted message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.100 [1803.1803] INFO QConnectMessageSender: [0x5563535dd960]: Sending MaxAudioQualityChanged message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.100 [1803.1803] INFO QwspMessageSender: [0x5563535dd940]: Sending Payload message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.149 [1803.1803] INFO PlaybackSessionManager: [0x5563533ca880]: Playback session has been refreshed May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.164 [1803.1803] INFO ProtocolHandler: [0x5563533cbaa0]: Received SetActive message: active May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.164 [1803.1803] INFO ProtocolHandler: [0x5563533cbaa0]: Received SetState message: May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.164 [1803.1803] INFO ProtocolHandler: [0x5563533cbaa0]: Playing state: Playing May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.164 [1803.1803] INFO ProtocolHandler: [0x5563533cbaa0]: Playback position: 8763 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO ProtocolHandler: [0x5563533cbaa0]: Queue version: 13.2 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO ProtocolHandler: [0x5563533cbaa0]: Current track: TID: 197320135, QID: 0, Context UUID: bfc084e2-3015-47ce-9228-1a59df6f31a4 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO ProtocolHandler: [0x5563533cbaa0]: Next track: TID: 87734280, QID: 1, Context UUID: bfc084e2-3015-47ce-9228-1a59df6f31a4 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO MediaEngine: [0x5563533cad50]: Stopping playback, clearing tracks May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO MediaEngine: [0x5563533cad50]: Initiating playback May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO RendererActionAvailabilityManager: [0x5563533cb960]: Renderer action 'Next' is available May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO ProtocolHandler: [0x5563533cbaa0]: Received SetLoopMode message: Off May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO PlaybackControlsManager: [0x5563533cb460]: Setting new loop mode: Off May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO MediaEngine: [0x5563533cad50]: Setting current track: 197320135, initial offset: 8763ms May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: Clearing all streams May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: New stream: 1 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO HttpDownloader: [0x55635357cf10]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=0f5b2c126a69180d35711380f2050d7a&request_ts=1747856537&track_id=197320135 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO HttpDownloader: [0x55635357f940]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=197320135 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO HttpDownloader: [0x5563533d7e00]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=2ce89e0ff1d61c216b1783a28a85b4e6&request_ts=1747856537&track_id=197320135 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: [Stream 1]: Running audio stream May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO ProtocolHandler: [0x5563533cbaa0]: Received SetShuffleMode message: disabled May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO PlaybackControlsManager: [0x5563533cb460]: Setting new shuffle mode: disabled May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO MediaEngine: [0x5563533cad50]: Setting next track: 87734280 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: New stream: 2 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO HttpDownloader: [0x5563533d97c0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=401b342a29d271ff8fb15cd162e34767&request_ts=1747856537&track_id=87734280 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO HttpDownloader: [0x5563533d9df0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=87734280 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.165 [1803.1803] INFO HttpDownloader: [0x5563533da3a0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=ddf629eaf6acaf1023545d78ba642b1b&request_ts=1747856537&track_id=87734280 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.167 [1803.1803] INFO MediaEngine: [0x5563533cad50]: Waiting for current stream to start before starting audio renderer May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.310 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2376575&eid=87734280&fmt=7&profile=raw&app_id=174516466&cid=1651531&etsp=1747860137&hmac=39PaAbR8rqoEi2CU5snUG84ch9o May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.325 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2376575&eid=197320135&fmt=7&profile=raw&app_id=174516466&cid=1651531&etsp=1747860137&hmac=e5XItFUh7xz7NtQu4061by-qjPI May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.346 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: [Stream 1]: stream information have been fetched May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.346 [1803.1803] INFO UrlAudioSource: [0x5563535fbe20]: Starting URL audio source, initial position: 8763ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=2376575&eid=197320135&fmt=7&profile=raw&app_id=174516466&cid=1651531&etsp=1747860137&hmac=e5XItFUh7xz7NtQu4061by-qjPI May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.347 [1803.1803] INFO ContentFetcher: [0x556353501ba0]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=2376575&eid=197320135&fmt=7&profile=raw&app_id=174516466&cid=1651531&etsp=1747860137&hmac=e5XItFUh7xz7NtQu4061by-qjPI, offset: 0 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.347 [1803.1803] INFO AudioRenderer: [0x5563533cb150]: Starting audio renderer, initial playback state: Playing May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.347 [1803.1803] INFO SampleApp: [Stream 1]: New audio stream (starting from 8763ms) May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: CorePlayQueue::getTrack 0 May 21 21:42:17 volumio volumio[1075]: info: QobuzConnect: setActiveState() May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: CorePlayQueue::getTrack 0 May 21 21:42:17 volumio volumio[1075]: info: QobuzConnect: Set Qobuz connect default volume to 100 May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.351 [1803.1803] INFO VolumeManager: [0x5563533cb550]: Setting new playback volume: 100 May 21 21:42:17 volumio volumio[1075]: info: CorePlayQueue::getTrack 0 May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: CorePlayQueue::getTrack 0 May 21 21:42:17 volumio volumio[1075]: info: QobuzConnect: Stopping currently active service May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioStop May 21 21:42:17 volumio volumio[1075]: info: CoreStateMachine::stop May 21 21:42:17 volumio volumio[1075]: info: CoreStateMachine::setConsumeUpdateService undefined May 21 21:42:17 volumio volumio[1075]: info: CoreStateMachine::setConsumeUpdateService undefined May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::servicePushState May 21 21:42:17 volumio volumio[1075]: info: CoreStateMachine::pushState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output update for this device May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: CorePlayQueue::getTrack 0 May 21 21:42:17 volumio volumio[1075]: verbose: STATE SERVICE {"status":"stop","service":"qobuzconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"qobuz","codec":"","seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false} May 21 21:42:17 volumio volumio[1075]: verbose: CURRENT POSITION 0 May 21 21:42:17 volumio volumio[1075]: info: CoreStateMachine::syncState stateService stop May 21 21:42:17 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus stop May 21 21:42:17 volumio volumio[1075]: info: CoreStateMachine::pushState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output update for this device May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: No code May 21 21:42:17 volumio volumio[1075]: info: CoreStateMachine::pushState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output update for this device May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect May 21 21:42:17 volumio volumio[1075]: info: QobuzConnect: setActiveState() completed, send playback confirmation May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.399 [1803.1803] INFO SampleApp: Initiating playback, initial state: Playing May 21 21:42:17 volumio volumio[1075]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.8ndMTVUwx8dwjNCIwjYIgcz5Mu32.920ff42f381ca3b523877aebb4ea4f4e.state.status' May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.717 [1803.1803] INFO SampleApp: Playback volume changed: 100 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.717 [1803.1803] INFO ProtocolHandler: [0x5563533cbaa0]: Volume changed: 100 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.717 [1803.1803] INFO QConnectMessageSender: [0x5563535dd960]: Sending VolumeChanged message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.718 [1803.1803] INFO QwspMessageSender: [0x5563535dd940]: Sending Payload message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.718 [1803.1803] INFO SampleApp: Playback state changed: Playing May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.719 [1803.1803] INFO StreamingEventReporter: [0x5563533cc240]: Reporting streaming started event May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.719 [1803.1803] INFO HttpDownloader: [0x5563533cc2d0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.719 [1803.1803] INFO ProtocolHandler: [0x5563533cbaa0]: Need to send state update May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.719 [1803.1803] INFO QConnectMessageSender: [0x5563535dd960]: Sending StateUpdated message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.719 [1803.1803] INFO QwspMessageSender: [0x5563535dd940]: Sending Payload message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.720 [1803.1803] INFO QConnectMessageSender: [0x5563535dd960]: Sending FileAudioQualityChanged message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.720 [1803.1803] INFO QwspMessageSender: [0x5563535dd940]: Sending Payload message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.720 [1803.1803] INFO QConnectMessageSender: [0x5563535dd960]: Sending DeviceAudioQualityChanged message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.720 [1803.1803] INFO QwspMessageSender: [0x5563535dd940]: Sending Payload message May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: [Stream 2]: stream information have been fetched May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: [Stream 1]: Metadata became available: May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: Title: The Bird Song May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: Artist: Anette Askvik May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: Album: Liberty May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: Album art URL: https://static.qobuz.com/images/covers/7b/pd/kn2j2wkyqpd7b_600.jpg May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: [Stream 2]: Metadata became available: May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::servicePushState May 21 21:42:17 volumio volumio[1075]: info: CoreStateMachine::pushState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: Title: The Summit May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: Artist: Avi Kaplan May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: Album: The Summit May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO AudioStreamManager: [0x5563533caef0]: Album art URL: https://static.qobuz.com/images/covers/xc/6k/jeevt1wlj6kxc_600.jpg May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO SampleApp: [Stream 1]: Stream metadata became available: May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.721 [1803.1803] INFO SampleApp: Title: The Bird Song May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.726 [1803.1803] INFO SampleApp: Artist: Anette Askvik May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.726 [1803.1803] INFO SampleApp: Album: Liberty May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.726 [1803.1803] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/7b/pd/kn2j2wkyqpd7b_600.jpg May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output update for this device May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.740 [1803.1803] INFO VolumeManager: [0x5563533cb550]: Setting new playback volume: 100 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.741 [1803.1803] INFO VolumeManager: [0x5563533cb550]: Setting new mute state: 0 May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::servicePushState May 21 21:42:17 volumio volumio[1075]: info: CoreStateMachine::pushState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output update for this device May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::servicePushState May 21 21:42:17 volumio volumio[1075]: info: CoreStateMachine::pushState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output update for this device May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::servicePushState May 21 21:42:17 volumio volumio[1075]: info: CoreStateMachine::pushState May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output update for this device May 21 21:42:17 volumio volumio[1075]: info: MRS: Pushing multiroomSync output May 21 21:42:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState May 21 21:42:17 volumio volumio[1075]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! May 21 21:42:17 volumio volumio[1075]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 21 21:42:17 volumio volumio[1075]: TypeError: Cannot read property 'indexOf' of undefined May 21 21:42:17 volumio volumio[1075]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) May 21 21:42:17 volumio volumio[1075]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) May 21 21:42:17 volumio volumio[1075]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) May 21 21:42:17 volumio volumio[1075]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 21 21:42:17 volumio volumio[1075]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) May 21 21:42:17 volumio volumio[1075]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) May 21 21:42:17 volumio volumio[1075]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 21 21:42:17 volumio volumio[1075]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 21 21:42:17 volumio volumio[1075]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) May 21 21:42:17 volumio volumio[1075]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 21 21:42:17 volumio volumio[1075]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) May 21 21:42:17 volumio volumio[1075]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) May 21 21:42:17 volumio volumio[1075]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) May 21 21:42:17 volumio volumio[1075]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 21 21:42:17 volumio volumio[1075]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 21 21:42:17 volumio volumio[1075]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) May 21 21:42:17 volumio volumio[1075]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.890 [1803.1803] INFO UrlAudioSource: [0x5563535fbe20]: Content info extracted May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.890 [1803.1803] INFO UrlAudioSource: [0x5563535fbe20]: Size: 39260568 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.890 [1803.2980] INFO AudioDecoder: [0x556353602c70]: Stream info: May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.890 [1803.2980] INFO AudioDecoder: [0x556353602c70]: Total samples: 10594560 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.890 [1803.2980] INFO AudioDecoder: [0x556353602c70]: Sample rate: 48000 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.890 [1803.2980] INFO AudioDecoder: [0x556353602c70]: Channel count: 2 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.890 [1803.2980] INFO AudioDecoder: [0x556353602c70]: Bits per sample: 24 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.890 [1803.2980] INFO AudioDecoder: [0x556353602c70]: Duration: 220720 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.890 [1803.1803] INFO UrlAudioSource: [0x5563535fbe20]: Audio properties have changed May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.890 [1803.1803] INFO UrlAudioSource: [0x5563535fbe20]: Seeking input stream to byte offset: 1632215 May 21 21:42:17 volumio qobuz-connect[1803]: 20250521 21:42:17.890 [1803.1803] INFO ContentFetcher: [0x556353501ba0]: Adjusting download offset to: 1632215 May 21 21:42:18 volumio sudo[2982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-21 21:41 May 21 21:42:18 volumio sudo[2982]: 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"