-- Logs begin at Fri 2025-05-16 04:44:10 CEST, end at Sat 2025-05-17 08:49:20 CEST. -- May 17 08:48:51 primo qobuz-connect[3464]: 20250517 08:48:51.274 [3464.920] INFO SampleApp: API endpoint invoked: get-display-info May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.565 [3464.920] INFO SampleApp: API endpoint invoked: get-connect-info May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.713 [3464.920] INFO SampleApp: API endpoint invoked: connect-to-qconnect May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.714 [3464.3464] INFO EndpointManager: [0xac6a9ec8]: Updating API endpoint May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.714 [3464.3464] INFO EndpointManager: [0xac6a9ec8]: Updating QConnect endpoint May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.714 [3464.3464] INFO ActiveStateManager: [0xac6a8ee0]: Setting new active state: active May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.714 [3464.3464] INFO PlaybackSessionManager: [0xac6aa2b8]: Starting playback session maintenance May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.714 [3464.3464] INFO HttpDownloader: [0xac6aa4a8]: Downloading content from: https://www.qobuz.com/api.json/0.2/session/start May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.714 [3464.3464] INFO CloudClient: [0xac6aab28]: Connecting to the cloud May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.715 [3464.3464] INFO SampleApp: Renderer is now active May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.954 [3464.3464] INFO CloudClient: [0xac6aab28]: Connection established May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.954 [3464.3464] INFO QwspMessageSender: [0xac7b3450]: Sending Authenticate message May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.954 [3464.3464] INFO QwspMessageSender: [0xac7b3450]: Sending Subscribe message May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.954 [3464.3464] INFO QConnectMessageSender: [0xac6ea560]: Sending JoinSession message May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.954 [3464.3464] INFO QConnectMessageSender: [0xac6ea560]: Sending VolumeChanged message May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.954 [3464.3464] INFO QConnectMessageSender: [0xac6ea560]: Sending VolumeMuted message May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.954 [3464.3464] INFO QConnectMessageSender: [0xac6ea560]: Sending MaxAudioQualityChanged message May 17 08:49:00 primo qobuz-connect[3464]: 20250517 08:49:00.955 [3464.3464] INFO QwspMessageSender: [0xac7b3450]: Sending Payload message May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.011 [3464.3464] INFO PlaybackSessionManager: [0xac6aa2b8]: Playback session has been refreshed May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.021 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Received SetActive message: active May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.021 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Received SetState message: May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.021 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Playing state: Stopped May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.022 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Playback position: May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.022 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Queue version: 1.1 May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.022 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Current track: TID: 4294967295, QID: -1, Context UUID: May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.022 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Next track: TID: 4294967295, QID: -1, Context UUID: May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.022 [3464.3464] INFO MediaEngine: [0xac6aa550]: Stopping playback, clearing tracks May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.022 [3464.3464] INFO MediaEngine: [0xac6aa550]: Stopping playback, keeping tracks May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.022 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Received SetLoopMode message: Off May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.022 [3464.3464] INFO PlaybackControlsManager: [0xac6aa928]: Setting new loop mode: Off May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.022 [3464.3464] INFO MediaEngine: [0xac6aa550]: Setting current track: NONE May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.022 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Received SetShuffleMode message: disabled May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.022 [3464.3464] INFO PlaybackControlsManager: [0xac6aa928]: Setting new shuffle mode: disabled May 17 08:49:01 primo qobuz-connect[3464]: 20250517 08:49:01.022 [3464.3464] INFO MediaEngine: [0xac6aa550]: Setting next track: NONE May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.576 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Received SetState message: May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.576 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Playing state: Playing May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.576 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Playback position: 0 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.576 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Queue version: 2.1 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.576 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Current track: TID: 307644376, QID: 1, Context UUID: ffcbc27e-f910-446a-a596-4096d45dcd4c May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.576 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Next track: TID: 307644377, QID: 2, Context UUID: ffcbc27e-f910-446a-a596-4096d45dcd4c May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.576 [3464.3464] INFO MediaEngine: [0xac6aa550]: Stopping playback, clearing tracks May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.576 [3464.3464] INFO MediaEngine: [0xac6aa550]: Initiating playback May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.576 [3464.3464] INFO RendererActionAvailabilityManager: [0xac6aabe0]: Renderer action 'Next' is available May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.576 [3464.3464] INFO MediaEngine: [0xac6aa550]: Setting current track: 307644376, initial offset: 0ms May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.576 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: Clearing all streams May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.576 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: New stream: 1 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.577 [3464.3464] INFO HttpDownloader: [0xac6adce0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=2deb189701c6e8b945a8fde3a426b4d1&request_ts=1747464559&track_id=307644376 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.577 [3464.3464] INFO HttpDownloader: [0xac6b6618]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=307644376 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.577 [3464.3464] INFO HttpDownloader: [0xac7858f0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=95fd64c3c09f26d3d93fb05cfaa49113&request_ts=1747464559&track_id=307644376 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.577 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: [Stream 1]: Running audio stream May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.578 [3464.3464] INFO MediaEngine: [0xac6aa550]: Setting next track: 307644377 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.578 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: New stream: 2 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.578 [3464.3464] INFO HttpDownloader: [0xac78a260]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=bc0d4f3497e079b8f828ac70745e593f&request_ts=1747464559&track_id=307644377 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.578 [3464.3464] INFO HttpDownloader: [0xac78a7f8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=307644377 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.579 [3464.3464] INFO HttpDownloader: [0xac78c808]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=4311025abdbb021227c8a9daa152c34d&request_ts=1747464559&track_id=307644377 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.580 [3464.3464] INFO MediaEngine: [0xac6aa550]: Waiting for current stream to start before starting audio renderer May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.713 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: [Stream 1]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1033204&eid=307644376&fmt=7&profile=raw&app_id=174516466&cid=2297896&etsp=1747468159&hmac=ABhhf94cpGPEY70BQO2S1QmKTYg May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.743 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: [Stream 2]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=1033204&eid=307644377&fmt=7&profile=raw&app_id=174516466&cid=2297896&etsp=1747468159&hmac=joRNJy519bRQlwXFSRKcdA8NXe4 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.743 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: [Stream 2]: stream information have been fetched May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.762 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: [Stream 1]: stream information have been fetched May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.762 [3464.3464] INFO UrlAudioSource: [0xac785d40]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=1033204&eid=307644376&fmt=7&profile=raw&app_id=174516466&cid=2297896&etsp=1747468159&hmac=ABhhf94cpGPEY70BQO2S1QmKTYg May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.762 [3464.3464] INFO ContentFetcher: [0xac6b2610]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=1033204&eid=307644376&fmt=7&profile=raw&app_id=174516466&cid=2297896&etsp=1747468159&hmac=ABhhf94cpGPEY70BQO2S1QmKTYg, offset: 0 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.762 [3464.3464] INFO AudioRenderer: [0xac6aa770]: Starting audio renderer, initial playback state: Playing May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.762 [3464.3464] INFO SampleApp: [Stream 1]: New audio stream (starting from 0ms) May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo volumio[3113]: info: QobuzConnect: setActiveState() May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo volumio[3113]: info: QobuzConnect: Set Qobuz connect default volume to 100 May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.770 [3464.3464] INFO VolumeManager: [0xac6aa9b8]: Setting new playback volume: 100 May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo volumio[3113]: info: QobuzConnect: Stopping currently active service May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioStop May 17 08:49:19 primo volumio[3113]: info: CoreStateMachine::stop May 17 08:49:19 primo volumio[3113]: info: CoreStateMachine::serviceStop May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::serviceStop May 17 08:49:19 primo volumio[3113]: info: CoreStateMachine::setConsumeUpdateService undefined May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::servicePushState May 17 08:49:19 primo volumio[3113]: info: CoreStateMachine::pushState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioPushState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo volumio[3113]: info: CorePlayQueue::getTrack 0 May 17 08:49:19 primo volumio[3113]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received qobuzconnect May 17 08:49:19 primo volumio[3113]: info: QobuzConnect: setActiveState(): setting Volatile state to qobuzconnect May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.783 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: [Stream 2]: Metadata became available: May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.783 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: Title: You Taught My Heart to Sing May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.783 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: Artist: Lucia May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.783 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: Album: Lucía May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.783 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: Album art URL: https://static.qobuz.com/images/covers/3a/fr/uqaewygrxfr3a_600.jpg May 17 08:49:19 primo volumio[3113]: info: QobuzConnect: setActiveState() completed, send playback confirmation May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.785 [3464.3464] INFO SampleApp: Initiating playback, initial state: Playing May 17 08:49:19 primo volumio[3113]: info: Updating RAAT Signal Path May 17 08:49:19 primo kernel: aml_tdm_open May 17 08:49:19 primo kernel: Not init audio effects May 17 08:49:19 primo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 May 17 08:49:19 primo kernel: set mclk:24576000, mpll:49152000, get mclk:24575987, mpll:49151974 May 17 08:49:19 primo kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc050e16418, id(1), clksel(1) May 17 08:49:19 primo kernel: aml_dai_set_tdm_fmt(), fmt not change May 17 08:49:19 primo kernel: dump_pcm_setting(ffffffc050e16418) May 17 08:49:19 primo kernel: pcm_mode(1) May 17 08:49:19 primo kernel: sysclk(24576000) May 17 08:49:19 primo kernel: sysclk_bclk_ratio(4) May 17 08:49:19 primo kernel: bclk(6144000) May 17 08:49:19 primo kernel: bclk_lrclk_ratio(64) May 17 08:49:19 primo kernel: lrclk(96000) May 17 08:49:19 primo kernel: tx_mask(0x3) May 17 08:49:19 primo kernel: rx_mask(0x3) May 17 08:49:19 primo kernel: slots(2) May 17 08:49:19 primo kernel: slot_width(32) May 17 08:49:19 primo kernel: lane_mask_in(0x2) May 17 08:49:19 primo kernel: lane_mask_out(0x1) May 17 08:49:19 primo kernel: lane_oe_mask_in(0x0) May 17 08:49:19 primo kernel: lane_oe_mask_out(0x0) May 17 08:49:19 primo kernel: lane_lb_mask_in(0x0) May 17 08:49:19 primo kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk May 17 08:49:19 primo kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk May 17 08:49:19 primo kernel: set mclk:24576000, mpll:49152000, get mclk:24575987, mpll:49151974 May 17 08:49:19 primo kernel: aml_dai_set_clkdiv, div 4, clksel(1) May 17 08:49:19 primo kernel: aml_dai_set_bclk_ratio, select I2S mode May 17 08:49:19 primo kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B May 17 08:49:19 primo kernel: aml_tdm_prepare(), reset fddr May 17 08:49:19 primo kernel: spdif_a fifo ctrl, frddr:0 type:4, 24 bits, chmask 0x3, swap 0x10 May 17 08:49:19 primo kernel: spdif_info: rate: 96000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0xa00, ch1_r:0xa00 May 17 08:49:19 primo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 May 17 08:49:19 primo kernel: tdm playback mute: 0, lane_cnt = 8 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.828 [3464.3464] INFO SampleApp: Playback state changed: Playing May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.828 [3464.3464] INFO StreamingEventReporter: [0xac6ab0a8]: Reporting streaming started event May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.828 [3464.3464] INFO HttpDownloader: [0xac6ab100]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.828 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Need to send state update May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.828 [3464.3464] INFO QConnectMessageSender: [0xac6ea560]: Sending StateUpdated message May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.829 [3464.3464] INFO QwspMessageSender: [0xac7b3450]: Sending Payload message May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.829 [3464.3464] INFO QConnectMessageSender: [0xac6ea560]: Sending FileAudioQualityChanged message May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.830 [3464.3464] INFO QwspMessageSender: [0xac7b3450]: Sending Payload message May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.830 [3464.3464] INFO QConnectMessageSender: [0xac6ea560]: Sending DeviceAudioQualityChanged message May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.830 [3464.3464] INFO QwspMessageSender: [0xac7b3450]: Sending Payload message May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.831 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: [Stream 1]: Metadata became available: May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.831 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: Title: Silencio May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.831 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: Artist: Lucia May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.831 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: Album: Lucía May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.831 [3464.3464] INFO AudioStreamManager: [0xac6aa638]: Album art URL: https://static.qobuz.com/images/covers/3a/fr/uqaewygrxfr3a_600.jpg May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.831 [3464.3464] INFO SampleApp: [Stream 1]: Stream metadata became available: May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.831 [3464.3464] INFO SampleApp: Title: Silencio May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.831 [3464.3464] INFO SampleApp: Artist: Lucia May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.831 [3464.3464] INFO SampleApp: Album: Lucía May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::servicePushState May 17 08:49:19 primo volumio[3113]: info: CoreStateMachine::pushState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioPushState May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.831 [3464.3464] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/3a/fr/uqaewygrxfr3a_600.jpg May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.837 [3464.3464] INFO VolumeManager: [0xac6aa9b8]: Setting new playback volume: 100 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.838 [3464.3464] INFO VolumeManager: [0xac6aa9b8]: Setting new mute state: 1 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.838 [3464.3464] INFO SampleApp: Playback mute state changed: 1 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.838 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Mute changed: 1 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.838 [3464.3464] INFO QConnectMessageSender: [0xac6ea560]: Sending VolumeMuted message May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.838 [3464.3464] INFO QwspMessageSender: [0xac7b3450]: Sending Payload message May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::servicePushState May 17 08:49:19 primo volumio[3113]: info: CoreStateMachine::pushState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioPushState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::servicePushState May 17 08:49:19 primo volumio[3113]: info: CoreStateMachine::pushState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioPushState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::servicePushState May 17 08:49:19 primo volumio[3113]: info: CoreStateMachine::pushState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioPushState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo volumio[3113]: info: QobuzConnect: Mute state: true May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: inputs , alsavolume May 17 08:49:19 primo volumio[3113]: info: CoreStateMachine::pushState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioPushState May 17 08:49:19 primo volumio[3113]: info: CoreCommandRouter::volumioGetState May 17 08:49:19 primo volumio[3113]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! May 17 08:49:19 primo volumio[3113]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 17 08:49:19 primo volumio[3113]: TypeError: Cannot read property 'indexOf' of undefined May 17 08:49:19 primo volumio[3113]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) May 17 08:49:19 primo volumio[3113]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) May 17 08:49:19 primo volumio[3113]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) May 17 08:49:19 primo volumio[3113]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 17 08:49:19 primo volumio[3113]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) May 17 08:49:19 primo volumio[3113]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) May 17 08:49:19 primo volumio[3113]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 17 08:49:19 primo volumio[3113]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 17 08:49:19 primo volumio[3113]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) May 17 08:49:19 primo volumio[3113]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 17 08:49:19 primo volumio[3113]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.934 [3464.3464] INFO SampleApp: Playback volume changed: 100 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.934 [3464.3464] INFO ProtocolHandler: [0xac6aac90]: Volume changed: 100 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.934 [3464.3464] INFO QConnectMessageSender: [0xac6ea560]: Sending VolumeChanged message May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.934 [3464.3464] INFO QwspMessageSender: [0xac7b3450]: Sending Payload message May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.957 [3464.3464] INFO UrlAudioSource: [0xac785d40]: Content info extracted May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.957 [3464.3464] INFO UrlAudioSource: [0xac785d40]: Size: 101119489 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.959 [3464.993] INFO AudioDecoder: [0xac943440]: Stream info: May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.959 [3464.993] INFO AudioDecoder: [0xac943440]: Total samples: 27484160 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.959 [3464.993] INFO AudioDecoder: [0xac943440]: Sample rate: 96000 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.959 [3464.993] INFO AudioDecoder: [0xac943440]: Channel count: 2 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.959 [3464.993] INFO AudioDecoder: [0xac943440]: Bits per sample: 24 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.960 [3464.993] INFO AudioDecoder: [0xac943440]: Duration: 286293 May 17 08:49:19 primo qobuz-connect[3464]: 20250517 08:49:19.960 [3464.3464] INFO UrlAudioSource: [0xac785d40]: Audio properties have changed May 17 08:49:19 primo kernel: asoc-aml-card auge_sound: tdm playback enable May 17 08:49:19 primo kernel: spdif_a is set to enable May 17 08:49:20 primo sudo[996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-17 08:48 May 17 08:49:20 primo sudo[996]: 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="armv7" VOLUMIO_VARIANT="primo2rev2" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 07:02:33 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Primo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Primo" VOLUMIO_HASH="905581800126f97a879a13768b481efc"