-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Thu 2025-05-15 23:06:00 CEST. -- May 15 23:05:02 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:06 homeaudio qobuz-connect[1523]: 20250515 23:05:06.364 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Need to send state update May 15 23:05:06 homeaudio qobuz-connect[1523]: 20250515 23:05:06.364 [1523.1523] INFO QConnectMessageSender: [0x2018818]: Sending StateUpdated message May 15 23:05:06 homeaudio qobuz-connect[1523]: 20250515 23:05:06.364 [1523.1523] INFO QwspMessageSender: [0x20afb38]: Sending Payload message May 15 23:05:06 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:06 homeaudio volumio[977]: info: CoreCommandRouter::servicePushState May 15 23:05:06 homeaudio volumio[977]: info: CoreStateMachine::pushState May 15 23:05:06 homeaudio volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 23:05:06 homeaudio volumio[977]: info: CoreCommandRouter::volumioPushState May 15 23:05:06 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output update for this device May 15 23:05:06 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output May 15 23:05:06 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:12 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:12 homeaudio volumio[977]: info: Listing playlists May 15 23:05:12 homeaudio volumio[977]: info: Listing playlists May 15 23:05:16 homeaudio qobuz-connect[1523]: 20250515 23:05:16.364 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Need to send state update May 15 23:05:16 homeaudio qobuz-connect[1523]: 20250515 23:05:16.364 [1523.1523] INFO QConnectMessageSender: [0x2018818]: Sending StateUpdated message May 15 23:05:16 homeaudio qobuz-connect[1523]: 20250515 23:05:16.364 [1523.1523] INFO QwspMessageSender: [0x20afb38]: Sending Payload message May 15 23:05:16 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:16 homeaudio volumio[977]: info: CoreCommandRouter::servicePushState May 15 23:05:16 homeaudio volumio[977]: info: CoreStateMachine::pushState May 15 23:05:16 homeaudio volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 23:05:16 homeaudio volumio[977]: info: CoreCommandRouter::volumioPushState May 15 23:05:16 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output update for this device May 15 23:05:16 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output May 15 23:05:16 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:16 homeaudio volumio[977]: error: [LastFM] plugin is not authenticated, please retry May 15 23:05:22 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:26 homeaudio qobuz-connect[1523]: 20250515 23:05:26.364 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Need to send state update May 15 23:05:26 homeaudio qobuz-connect[1523]: 20250515 23:05:26.364 [1523.1523] INFO QConnectMessageSender: [0x2018818]: Sending StateUpdated message May 15 23:05:26 homeaudio qobuz-connect[1523]: 20250515 23:05:26.364 [1523.1523] INFO QwspMessageSender: [0x20afb38]: Sending Payload message May 15 23:05:26 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:26 homeaudio volumio[977]: info: CoreCommandRouter::servicePushState May 15 23:05:26 homeaudio volumio[977]: info: CoreStateMachine::pushState May 15 23:05:26 homeaudio volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 23:05:26 homeaudio volumio[977]: info: CoreCommandRouter::volumioPushState May 15 23:05:26 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output update for this device May 15 23:05:26 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output May 15 23:05:26 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:28 homeaudio go-librespot[1189]: time="2025-05-15T23:05:28+02:00" level=trace msg="sent dealer ping" May 15 23:05:28 homeaudio go-librespot[1189]: time="2025-05-15T23:05:28+02:00" level=trace msg="received dealer pong" May 15 23:05:32 homeaudio go-librespot[1189]: time="2025-05-15T23:05:32+02:00" level=trace msg="received accesspoint ping" May 15 23:05:32 homeaudio go-librespot[1189]: time="2025-05-15T23:05:32+02:00" level=trace msg="received accesspoint pong ack" May 15 23:05:32 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:32 homeaudio volumio[977]: info: Listing playlists May 15 23:05:32 homeaudio volumio[977]: info: Listing playlists May 15 23:05:36 homeaudio qobuz-connect[1523]: 20250515 23:05:36.363 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Need to send state update May 15 23:05:36 homeaudio qobuz-connect[1523]: 20250515 23:05:36.363 [1523.1523] INFO QConnectMessageSender: [0x2018818]: Sending StateUpdated message May 15 23:05:36 homeaudio qobuz-connect[1523]: 20250515 23:05:36.364 [1523.1523] INFO QwspMessageSender: [0x20afb38]: Sending Payload message May 15 23:05:36 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:36 homeaudio volumio[977]: info: CoreCommandRouter::servicePushState May 15 23:05:36 homeaudio volumio[977]: info: CoreStateMachine::pushState May 15 23:05:36 homeaudio volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 23:05:36 homeaudio volumio[977]: info: CoreCommandRouter::volumioPushState May 15 23:05:36 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output update for this device May 15 23:05:36 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output May 15 23:05:36 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:42 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:46 homeaudio qobuz-connect[1523]: 20250515 23:05:46.364 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Need to send state update May 15 23:05:46 homeaudio qobuz-connect[1523]: 20250515 23:05:46.364 [1523.1523] INFO QConnectMessageSender: [0x2018818]: Sending StateUpdated message May 15 23:05:46 homeaudio qobuz-connect[1523]: 20250515 23:05:46.364 [1523.1523] INFO QwspMessageSender: [0x20afb38]: Sending Payload message May 15 23:05:46 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:46 homeaudio volumio[977]: info: CoreCommandRouter::servicePushState May 15 23:05:46 homeaudio volumio[977]: info: CoreStateMachine::pushState May 15 23:05:46 homeaudio volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 23:05:46 homeaudio volumio[977]: info: CoreCommandRouter::volumioPushState May 15 23:05:46 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output update for this device May 15 23:05:46 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output May 15 23:05:46 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:52 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:52 homeaudio volumio[977]: info: Listing playlists May 15 23:05:52 homeaudio volumio[977]: info: Listing playlists May 15 23:05:56 homeaudio qobuz-connect[1523]: 20250515 23:05:56.363 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Need to send state update May 15 23:05:56 homeaudio qobuz-connect[1523]: 20250515 23:05:56.363 [1523.1523] INFO QConnectMessageSender: [0x2018818]: Sending StateUpdated message May 15 23:05:56 homeaudio qobuz-connect[1523]: 20250515 23:05:56.364 [1523.1523] INFO QwspMessageSender: [0x20afb38]: Sending Payload message May 15 23:05:56 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:56 homeaudio volumio[977]: info: CoreCommandRouter::servicePushState May 15 23:05:56 homeaudio volumio[977]: info: CoreStateMachine::pushState May 15 23:05:56 homeaudio volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 23:05:56 homeaudio volumio[977]: info: CoreCommandRouter::volumioPushState May 15 23:05:56 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output update for this device May 15 23:05:56 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output May 15 23:05:56 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:58 homeaudio go-librespot[1189]: time="2025-05-15T23:05:58+02:00" level=trace msg="sent dealer ping" May 15 23:05:58 homeaudio go-librespot[1189]: time="2025-05-15T23:05:58+02:00" level=trace msg="received dealer pong" May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.042 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Received SetState message: May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.042 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Playing state: Playing May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.042 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Playback position: 0 May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.042 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Queue version: 35.1 May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.042 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Current track: TID: 307152719, QID: 2, Context UUID: 1d42167c-e7fb-4957-9a51-979e6d040a97 May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.042 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Next track: TID: 4294967295, QID: -1, Context UUID: May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.042 [1523.1523] INFO MediaEngine: [0x1f86670]: Stopping playback, clearing tracks May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.042 [1523.1523] INFO MediaEngine: [0x1f86670]: Initiating playback May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.042 [1523.1523] INFO AudioRenderer: [0x1f86890]: Stopping audio renderer May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.042 [1523.1523] INFO RendererActionAvailabilityManager: [0x1f86d00]: Renderer action 'Next' is not available May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.043 [1523.1523] INFO SampleApp: Stopping playback May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.043 [1523.1523] INFO AudioStreamManager: [0x1f86758]: Clearing all streams May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.044 [1523.1523] INFO AudioStreamManager: [0x1f86758]: [Stream 15]: Disposing of audio stream May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.044 [1523.1523] INFO ContentFetcher: [0x202c058]: Canceling download May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.050 [1523.1523] INFO SampleApp: Playback state changed: Stopped May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.050 [1523.1523] INFO StreamingEventReporter: [0x1f871c8]: Reporting streaming ended event May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.050 [1523.1523] INFO HttpDownloader: [0x1f87220]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingEndJson May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.050 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Need to send state update May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.051 [1523.1523] INFO QConnectMessageSender: [0x2018818]: Sending StateUpdated message May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.051 [1523.1523] INFO SampleApp: [Stream 15]: Audio stream has been disposed of May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.051 [1523.1523] INFO MediaEngine: [0x1f86670]: Setting current track: 307152719, initial offset: 0ms May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.051 [1523.1523] INFO AudioStreamManager: [0x1f86758]: Clearing all streams May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.051 [1523.1523] INFO AudioStreamManager: [0x1f86758]: New stream: 17 May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.051 [1523.1523] INFO HttpDownloader: [0x1fe0bb8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=7eb172f6ac3eec6ac1ec44d31b4fe9b5&request_ts=1747343159&track_id=307152719 May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.051 [1523.1523] INFO HttpDownloader: [0x21aee58]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=307152719 May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::servicePushState May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.051 [1523.1523] INFO HttpDownloader: [0x2061fb0]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=7b78eaa738c2215135f377b6b506a65c&request_ts=1747343159&track_id=307152719 May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.051 [1523.1523] INFO AudioStreamManager: [0x1f86758]: [Stream 17]: Running audio stream May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.051 [1523.1523] INFO QwspMessageSender: [0x20afb38]: Sending Payload message May 15 23:05:59 homeaudio volumio[977]: info: CoreStateMachine::pushState May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioPushState May 15 23:05:59 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output update for this device May 15 23:05:59 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.060 [1523.1523] INFO MediaEngine: [0x1f86670]: Setting next track: NONE May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.060 [1523.1523] INFO MediaEngine: [0x1f86670]: Waiting for current stream to start before starting audio renderer May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::servicePushState May 15 23:05:59 homeaudio volumio[977]: info: CoreStateMachine::pushState May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioPushState May 15 23:05:59 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output update for this device May 15 23:05:59 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.450 [1523.1523] INFO AudioStreamManager: [0x1f86758]: [Stream 17]: track URL resolved to: https://streaming-qobuz-std.akamaized.net/file?uid=2480132&eid=307152719&fmt=6&profile=raw&app_id=174516466&cid=2524027&etsp=1747346759&hmac=RBnLUxDFW6XENjfzgbsiiqh-jUM May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.487 [1523.1523] INFO AudioStreamManager: [0x1f86758]: [Stream 17]: stream information have been fetched May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.487 [1523.1523] INFO UrlAudioSource: [0x24ccc20]: Starting URL audio source, initial position: 0ms, URL: https://streaming-qobuz-std.akamaized.net/file?uid=2480132&eid=307152719&fmt=6&profile=raw&app_id=174516466&cid=2524027&etsp=1747346759&hmac=RBnLUxDFW6XENjfzgbsiiqh-jUM May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.487 [1523.1523] INFO ContentFetcher: [0x202d450]: Fetching content from: https://streaming-qobuz-std.akamaized.net/file?uid=2480132&eid=307152719&fmt=6&profile=raw&app_id=174516466&cid=2524027&etsp=1747346759&hmac=RBnLUxDFW6XENjfzgbsiiqh-jUM, offset: 0 May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.487 [1523.1523] INFO AudioRenderer: [0x1f86890]: Starting audio renderer, initial playback state: Playing May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.487 [1523.1523] INFO SampleApp: [Stream 17]: New audio stream (starting from 0ms) May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:59 homeaudio volumio[977]: info: QobuzConnect: alread currrent service, send playback confirmation May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.489 [1523.1523] INFO SampleApp: Initiating playback, initial state: Playing May 15 23:05:59 homeaudio qobuz-connect[1523]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:257:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioOutput has buffer size 88200 May 15 23:05:59 homeaudio qobuz-connect[1523]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:268:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioOutput has buffer size 88200 May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.492 [1523.1523] INFO SampleApp: Playback state changed: Playing May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.492 [1523.1523] INFO StreamingEventReporter: [0x1f871c8]: Reporting streaming started event May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.492 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Need to send state update May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.492 [1523.1523] INFO QConnectMessageSender: [0x2018818]: Sending StateUpdated message May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.492 [1523.1523] INFO QwspMessageSender: [0x20afb38]: Sending Payload message May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.492 [1523.1523] INFO QConnectMessageSender: [0x2018818]: Sending FileAudioQualityChanged message May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.493 [1523.1523] INFO QwspMessageSender: [0x20afb38]: Sending Payload message May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.493 [1523.1523] INFO QConnectMessageSender: [0x2018818]: Sending DeviceAudioQualityChanged message May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.493 [1523.1523] INFO QwspMessageSender: [0x20afb38]: Sending Payload message May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::servicePushState May 15 23:05:59 homeaudio volumio[977]: info: CoreStateMachine::pushState May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioPushState May 15 23:05:59 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output update for this device May 15 23:05:59 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.507 [1523.1523] INFO HttpDownloader: [0x1f87220]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/reportStreamingStart May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::servicePushState May 15 23:05:59 homeaudio volumio[977]: info: CoreStateMachine::pushState May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioPushState May 15 23:05:59 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output update for this device May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.512 [1523.1523] INFO AudioStreamManager: [0x1f86758]: [Stream 17]: Metadata became available: May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.512 [1523.1523] INFO AudioStreamManager: [0x1f86758]: Title: Spacer Woman (Acid Trip Version) May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.513 [1523.1523] INFO AudioStreamManager: [0x1f86758]: Artist: Romain FX May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.513 [1523.1523] INFO AudioStreamManager: [0x1f86758]: Album: Spacer Woman (Acid Trip Version) May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.513 [1523.1523] INFO AudioStreamManager: [0x1f86758]: Album art URL: https://static.qobuz.com/images/covers/8b/m3/wepbild7gm38b_600.jpg May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.513 [1523.1523] INFO SampleApp: [Stream 17]: Stream metadata became available: May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.513 [1523.1523] INFO SampleApp: Title: Spacer Woman (Acid Trip Version) May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.513 [1523.1523] INFO SampleApp: Artist: Romain FX May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.513 [1523.1523] INFO SampleApp: Album: Spacer Woman (Acid Trip Version) May 15 23:05:59 homeaudio qobuz-connect[1523]: 20250515 23:05:59.513 [1523.1523] INFO SampleApp: Album art URL: https://static.qobuz.com/images/covers/8b/m3/wepbild7gm38b_600.jpg May 15 23:05:59 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::servicePushState May 15 23:05:59 homeaudio volumio[977]: info: CoreStateMachine::pushState May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioPushState May 15 23:05:59 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output update for this device May 15 23:05:59 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::servicePushState May 15 23:05:59 homeaudio volumio[977]: info: CoreStateMachine::pushState May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioPushState May 15 23:05:59 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output update for this device May 15 23:05:59 homeaudio volumio[977]: info: MRS: Pushing multiroomSync output May 15 23:05:59 homeaudio volumio[977]: info: CoreCommandRouter::volumioGetState May 15 23:05:59 homeaudio volumio[977]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! May 15 23:05:59 homeaudio volumio[977]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 23:05:59 homeaudio volumio[977]: TypeError: Cannot read property 'indexOf' of undefined May 15 23:05:59 homeaudio volumio[977]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) May 15 23:05:59 homeaudio volumio[977]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) May 15 23:05:59 homeaudio volumio[977]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) May 15 23:05:59 homeaudio volumio[977]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 15 23:05:59 homeaudio volumio[977]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) May 15 23:05:59 homeaudio volumio[977]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) May 15 23:05:59 homeaudio volumio[977]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 15 23:05:59 homeaudio volumio[977]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 15 23:05:59 homeaudio volumio[977]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) May 15 23:05:59 homeaudio volumio[977]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 15 23:05:59 homeaudio volumio[977]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) May 15 23:05:59 homeaudio volumio[977]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) May 15 23:05:59 homeaudio volumio[977]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) May 15 23:05:59 homeaudio volumio[977]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) May 15 23:05:59 homeaudio volumio[977]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) May 15 23:05:59 homeaudio volumio[977]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) May 15 23:05:59 homeaudio volumio[977]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.090 [1523.1523] INFO UrlAudioSource: [0x24ccc20]: Content info extracted May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.090 [1523.1523] INFO UrlAudioSource: [0x24ccc20]: Size: 42677769 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.090 [1523.23374] INFO AudioDecoder: [0x22e0fb0]: Stream info: May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.090 [1523.23374] INFO AudioDecoder: [0x22e0fb0]: Total samples: 16454876 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.090 [1523.23374] INFO AudioDecoder: [0x22e0fb0]: Sample rate: 44100 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.090 [1523.23374] INFO AudioDecoder: [0x22e0fb0]: Channel count: 2 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.090 [1523.23374] INFO AudioDecoder: [0x22e0fb0]: Bits per sample: 16 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.090 [1523.23374] INFO AudioDecoder: [0x22e0fb0]: Duration: 373126 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.090 [1523.1523] INFO UrlAudioSource: [0x24ccc20]: Audio properties have changed May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.103 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Received SetState message: May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.103 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Playing state: May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.103 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Playback position: May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.103 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Queue version: 35.2 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.103 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Current track: May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.103 [1523.1523] INFO ProtocolHandler: [0x1f86db0]: Next track: TID: 81240137, QID: 3, Context UUID: 6b47c30a-dfb2-4535-bc8e-6030eb9dc0f1 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.103 [1523.1523] INFO MediaEngine: [0x1f86670]: Setting next track: 81240137 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.103 [1523.1523] INFO AudioStreamManager: [0x1f86758]: New stream: 18 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.104 [1523.1523] INFO HttpDownloader: [0x22e11d8]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&request_sig=b6284dc5269bc65b2ca7522ebbdd5634&request_ts=1747343160&track_id=81240137 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.104 [1523.1523] INFO HttpDownloader: [0x249c1a0]: Downloading content from: https://www.qobuz.com/api.json/0.2/track/get?track_id=81240137 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.104 [1523.1523] INFO HttpDownloader: [0x2597580]: Downloading content from: https://www.qobuz.com/api.json/0.2/file/url?format_id=27&intent=stream&request_sig=979d0bffb166c5b98c4099c9d78d236d&request_ts=1747343160&track_id=81240137 May 15 23:06:00 homeaudio qobuz-connect[1523]: 20250515 23:06:00.104 [1523.1523] INFO RendererActionAvailabilityManager: [0x1f86d00]: Renderer action 'Next' is available May 15 23:06:00 homeaudio sudo[23376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-15 23:05 May 15 23:06:00 homeaudio sudo[23376]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"